builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0013 starttime: 1446468546.95 results: success (0) buildid: 20151102030710 builduid: ae6e2147ce7a4d8298204e7cab334bc4 revision: cbb27a88e499604c4bf0be54eb5373a001f8cf62 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:06.952269) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:06.952738) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:06.953032) ========= 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.kT1FYdZPae/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.fwZiDRp86a/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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.005732 basedir: '/builds/slave/test' ========= master_lag: 0.26 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.222743) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.223107) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.252380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.252797) ========= 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.kT1FYdZPae/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.fwZiDRp86a/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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.013065 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.301505) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.304886) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.305310) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.305616) ========= 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.kT1FYdZPae/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.fwZiDRp86a/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-02 04:49:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-02 04:49:07 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.288476 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.612633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.613108) ========= 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.kT1FYdZPae/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.fwZiDRp86a/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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.211499 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.839464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:07.839827) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cbb27a88e499604c4bf0be54eb5373a001f8cf62 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev cbb27a88e499604c4bf0be54eb5373a001f8cf62 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kT1FYdZPae/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.fwZiDRp86a/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-02 04:49:07,936 truncating revision to first 12 chars 2015-11-02 04:49:07,937 Setting DEBUG logging. 2015-11-02 04:49:07,937 attempt 1/10 2015-11-02 04:49:07,937 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cbb27a88e499?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-02 04:49:08,213 unpacking tar archive at: fx-team-cbb27a88e499/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:08.405440) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:08.405809) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:08.419470) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:08.419902) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-02 04:49:08.420383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2015-11-02 04:49:08.420724) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kT1FYdZPae/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.fwZiDRp86a/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 04:49:08 INFO - MultiFileLogger online at 20151102 04:49:08 in /builds/slave/test 04:49:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:49:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:49:08 INFO - {'append_to_log': False, 04:49:08 INFO - 'base_work_dir': '/builds/slave/test', 04:49:08 INFO - 'blob_upload_branch': 'Fx-Team', 04:49:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:49:08 INFO - 'branch': 'Fx-Team', 04:49:08 INFO - 'buildbot_json_path': 'buildprops.json', 04:49:08 INFO - 'config_files': ('talos/mac_config.py',), 04:49:08 INFO - 'default_actions': ('clobber', 04:49:08 INFO - 'read-buildbot-config', 04:49:08 INFO - 'download-and-extract', 04:49:08 INFO - 'populate-webroot', 04:49:08 INFO - 'create-virtualenv', 04:49:08 INFO - 'install', 04:49:08 INFO - 'run-tests'), 04:49:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:49:08 INFO - 'download_minidump_stackwalk': True, 04:49:08 INFO - 'download_symbols': 'ondemand', 04:49:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:49:08 INFO - 'tooltool.py': '/tools/tooltool.py', 04:49:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:49:08 INFO - '/tools/misc-python/virtualenv.py')}, 04:49:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:49:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:49:08 INFO - 'installer_path': 'installer.exe', 04:49:08 INFO - 'log_level': 'info', 04:49:08 INFO - 'log_name': 'talos', 04:49:08 INFO - 'log_to_console': True, 04:49:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:49:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:49:08 INFO - 'opt_config_files': (), 04:49:08 INFO - 'pip_index': False, 04:49:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:49:08 INFO - 'cmd': ('bash', 04:49:08 INFO - '-c', 04:49:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:49:08 INFO - 'enabled': True, 04:49:08 INFO - 'halt_on_failure': False, 04:49:08 INFO - 'name': 'check_screen_resolution'},), 04:49:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:49:08 INFO - 'cmd': ('bash', 04:49:08 INFO - '-c', 04:49:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:49:08 INFO - 'enabled': True, 04:49:08 INFO - 'halt_on_failure': False, 04:49:08 INFO - 'name': 'check_screen_resolution'},), 04:49:08 INFO - 'run_cmd_checks_enabled': True, 04:49:08 INFO - 'sps_profile': False, 04:49:08 INFO - 'sps_profile_interval': 0, 04:49:08 INFO - 'suite': 'dromaeojs', 04:49:08 INFO - 'system_bits': '64', 04:49:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:49:08 INFO - 'title': 't-yosemite-r5-0013', 04:49:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:49:08 INFO - 'use_talos_json': True, 04:49:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:49:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:49:08 INFO - 'work_dir': 'build'} 04:49:08 INFO - ##### 04:49:08 INFO - ##### Running clobber step. 04:49:08 INFO - ##### 04:49:08 INFO - Running pre-action listener: _resource_record_pre_action 04:49:08 INFO - Running main action method: clobber 04:49:08 INFO - rmtree: /builds/slave/test/build 04:49:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:49:11 INFO - Running post-action listener: _resource_record_post_action 04:49:11 INFO - ##### 04:49:11 INFO - ##### Running read-buildbot-config step. 04:49:11 INFO - ##### 04:49:11 INFO - Running pre-action listener: _resource_record_pre_action 04:49:11 INFO - Running main action method: read_buildbot_config 04:49:11 INFO - Using buildbot properties: 04:49:11 INFO - { 04:49:11 INFO - "properties": { 04:49:11 INFO - "buildnumber": 1183, 04:49:11 INFO - "product": "firefox", 04:49:11 INFO - "script_repo_revision": "production", 04:49:11 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 04:49:11 INFO - "repository": "", 04:49:11 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 04:49:11 INFO - "buildid": "20151102030710", 04:49:11 INFO - "slavename": "t-yosemite-r5-0013", 04:49:11 INFO - "pgo_build": "False", 04:49:11 INFO - "basedir": "/builds/slave/test", 04:49:11 INFO - "project": "", 04:49:11 INFO - "platform": "yosemite", 04:49:11 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:49:11 INFO - "slavebuilddir": "test", 04:49:11 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:49:11 INFO - "branch": "fx-team", 04:49:11 INFO - "repo_path": "integration/fx-team", 04:49:11 INFO - "stage_platform": "macosx64", 04:49:11 INFO - "builduid": "ae6e2147ce7a4d8298204e7cab334bc4", 04:49:11 INFO - "revision": "cbb27a88e499604c4bf0be54eb5373a001f8cf62" 04:49:11 INFO - }, 04:49:11 INFO - "sourcestamp": { 04:49:11 INFO - "repository": "", 04:49:11 INFO - "hasPatch": false, 04:49:11 INFO - "project": "", 04:49:11 INFO - "branch": "fx-team-macosx64-talos", 04:49:11 INFO - "changes": [ 04:49:11 INFO - { 04:49:11 INFO - "category": null, 04:49:11 INFO - "files": [ 04:49:11 INFO - { 04:49:11 INFO - "url": null, 04:49:11 INFO - "name": "https://queue.taskcluster.net/v1/task/wD7hmYhJQH-ET6MnBNI1jQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 04:49:11 INFO - } 04:49:11 INFO - ], 04:49:11 INFO - "repository": "", 04:49:11 INFO - "rev": "89a683d15226f8348557e32ab30b5bd65df6bd10", 04:49:11 INFO - "who": "pbrosset@mozilla.com", 04:49:11 INFO - "when": 1446467971, 04:49:11 INFO - "number": 6608993, 04:49:11 INFO - "comments": "Bug 1205704 - Show an icon and tooltip when animations are running on the compositor; r=tromey", 04:49:11 INFO - "project": "", 04:49:11 INFO - "at": "Mon 02 Nov 2015 04:39:31", 04:49:11 INFO - "branch": "fx-team-macosx64-talos", 04:49:11 INFO - "revlink": "", 04:49:11 INFO - "properties": [ 04:49:11 INFO - [ 04:49:11 INFO - "buildid", 04:49:11 INFO - "20151102025405", 04:49:11 INFO - "Change" 04:49:11 INFO - ], 04:49:11 INFO - [ 04:49:11 INFO - "builduid", 04:49:11 INFO - "5e528a7cd33542f3b89a7f0b7c83907e", 04:49:11 INFO - "Change" 04:49:11 INFO - ], 04:49:11 INFO - [ 04:49:11 INFO - "pgo_build", 04:49:11 INFO - "False", 04:49:11 INFO - "Change" 04:49:11 INFO - ] 04:49:11 INFO - ], 04:49:11 INFO - "revision": "89a683d15226f8348557e32ab30b5bd65df6bd10" 04:49:11 INFO - }, 04:49:11 INFO - { 04:49:11 INFO - "category": null, 04:49:11 INFO - "files": [ 04:49:11 INFO - { 04:49:11 INFO - "url": null, 04:49:11 INFO - "name": "https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 04:49:11 INFO - } 04:49:11 INFO - ], 04:49:11 INFO - "repository": "", 04:49:11 INFO - "rev": "cbb27a88e499604c4bf0be54eb5373a001f8cf62", 04:49:11 INFO - "who": "cbook@mozilla.com", 04:49:11 INFO - "when": 1446467882, 04:49:11 INFO - "number": 6608982, 04:49:11 INFO - "comments": "Merge mozilla-central to fx-team", 04:49:11 INFO - "project": "", 04:49:11 INFO - "at": "Mon 02 Nov 2015 04:38:02", 04:49:11 INFO - "branch": "fx-team-macosx64-talos", 04:49:11 INFO - "revlink": "", 04:49:11 INFO - "properties": [ 04:49:11 INFO - [ 04:49:11 INFO - "buildid", 04:49:11 INFO - "20151102030710", 04:49:11 INFO - "Change" 04:49:11 INFO - ], 04:49:11 INFO - [ 04:49:11 INFO - "builduid", 04:49:11 INFO - "ae6e2147ce7a4d8298204e7cab334bc4", 04:49:11 INFO - "Change" 04:49:11 INFO - ], 04:49:11 INFO - [ 04:49:11 INFO - "pgo_build", 04:49:11 INFO - "False", 04:49:11 INFO - "Change" 04:49:11 INFO - ] 04:49:11 INFO - ], 04:49:11 INFO - "revision": "cbb27a88e499604c4bf0be54eb5373a001f8cf62" 04:49:11 INFO - } 04:49:11 INFO - ], 04:49:11 INFO - "revision": "cbb27a88e499604c4bf0be54eb5373a001f8cf62" 04:49:11 INFO - } 04:49:11 INFO - } 04:49:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 04:49:11 INFO - Running post-action listener: _resource_record_post_action 04:49:11 INFO - ##### 04:49:11 INFO - ##### Running download-and-extract step. 04:49:11 INFO - ##### 04:49:11 INFO - Running pre-action listener: _resource_record_pre_action 04:49:11 INFO - Running main action method: download_and_extract 04:49:11 INFO - mkdir: /builds/slave/test/build/tests 04:49: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')]} 04:49:11 INFO - https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:49:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/test_packages.json 04:49:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/test_packages.json 04:49:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:49:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:49:13 INFO - Downloaded 1149 bytes. 04:49:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:49:13 INFO - Using the following test package requirements: 04:49:13 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:49:13 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:49:13 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 04:49:13 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:49:13 INFO - u'jsshell-mac.zip'], 04:49:13 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:49:13 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 04:49:13 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:49:13 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:49:13 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 04:49:13 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:49:13 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 04:49:13 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:49:13 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 04:49:13 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 04:49:13 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 04:49:13 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 04:49:13 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:49:13 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')]} 04:49:13 INFO - https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:49:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:49:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:49:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:49:14 INFO - Downloaded 17452522 bytes. 04:49:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 04:49:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:49:14 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:49:19 INFO - Return code: 0 04:49:19 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:49:19 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')]} 04:49:19 INFO - https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:49:20 INFO - Downloaded 17452522 bytes. 04:49:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 04:49:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 04:49:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 04:49:25 INFO - Return code: 0 04:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:25 INFO - https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:49:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:49:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:49:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:49:26 INFO - Downloaded 11131307 bytes. 04:49:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 04:49:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 04:49:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 04:49:27 INFO - Return code: 0 04:49:27 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')]} 04:49:27 INFO - https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:49:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:49:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:49:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 04:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 04:49:30 INFO - Downloaded 108569204 bytes. 04:49:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:49:30 INFO - mkdir: /builds/slave/test/properties 04:49:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:30 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:30 INFO - Contents: 04:49:30 INFO - build_url:https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 04:49:30 INFO - Running post-action listener: _resource_record_post_action 04:49:30 INFO - Running post-action listener: set_extra_try_arguments 04:49:30 INFO - ##### 04:49:30 INFO - ##### Running populate-webroot step. 04:49:30 INFO - ##### 04:49:30 INFO - Running pre-action listener: _resource_record_pre_action 04:49:30 INFO - Running main action method: populate_webroot 04:49:30 INFO - Guessing talos json url... 04:49: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')]} 04:49:30 INFO - https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 04:49:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 04:49:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 04:49:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 04:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 04:49:30 INFO - Downloaded 103 bytes. 04:49:30 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 04:49:30 INFO - Contents: 04:49:30 INFO - 20151102030710 04:49:30 INFO - https://hg.mozilla.org/integration/fx-team/rev/cbb27a88e499604c4bf0be54eb5373a001f8cf62 04:49: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')]} 04:49:30 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/cbb27a88e4/testing/talos/talos.json 04:49:30 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/cbb27a88e4/testing/talos/talos.json to /builds/slave/test/build/talos.json 04:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/cbb27a88e4/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 04:49:31 INFO - Downloaded 4264 bytes. 04:49:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:31 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:49:31 INFO - '../fennec_ids.txt'], 04:49:31 INFO - 'tests': ['tcheck2']}, 04:49:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:31 INFO - '--tppagecycles', 04:49:31 INFO - '7'], 04:49:31 INFO - 'tests': ['tsvgm']}}, 04:49:31 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:49:31 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:49:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:31 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:49:31 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:49:31 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:49:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:31 INFO - 'talos_options': ['--e10s'], 04:49:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:31 INFO - 'tests': ['damp', 'tps']}, 04:49:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:31 INFO - 'talos_options': ['--e10s'], 04:49:31 INFO - 'tests': ['damp', 'tps']}, 04:49:31 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:49:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:31 INFO - 'other': {'tests': ['a11yr', 04:49:31 INFO - 'ts_paint', 04:49:31 INFO - 'tpaint', 04:49:31 INFO - 'sessionrestore', 04:49:31 INFO - 'sessionrestore_no_auto_restore']}, 04:49:31 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:49:31 INFO - 'tests': ['a11yr', 04:49:31 INFO - 'ts_paint', 04:49:31 INFO - 'tpaint', 04:49:31 INFO - 'sessionrestore', 04:49:31 INFO - 'sessionrestore_no_auto_restore']}, 04:49:31 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:49:31 INFO - 'tests': ['a11yr', 04:49:31 INFO - 'ts_paint', 04:49:31 INFO - 'tpaint', 04:49:31 INFO - 'sessionrestore', 04:49:31 INFO - 'sessionrestore_no_auto_restore']}, 04:49:31 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:49:31 INFO - 'tests': ['a11yr', 04:49:31 INFO - 'ts_paint', 04:49:31 INFO - 'tpaint', 04:49:31 INFO - 'sessionrestore', 04:49:31 INFO - 'sessionrestore_no_auto_restore']}, 04:49:31 INFO - 'other_l64': {'tests': ['a11yr', 04:49:31 INFO - 'ts_paint', 04:49:31 INFO - 'tpaint', 04:49:31 INFO - 'sessionrestore', 04:49:31 INFO - 'sessionrestore_no_auto_restore']}, 04:49:31 INFO - 'other_nol64': {'tests': ['a11yr', 04:49:31 INFO - 'ts_paint', 04:49:31 INFO - 'tpaint', 04:49:31 INFO - 'sessionrestore', 04:49:31 INFO - 'sessionrestore_no_auto_restore']}, 04:49:31 INFO - 'svgr': {'tests': ['tsvgx', 04:49:31 INFO - 'tsvgr_opacity', 04:49:31 INFO - 'tart', 04:49:31 INFO - 'tscrollx', 04:49:31 INFO - 'cart']}, 04:49:31 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:49:31 INFO - 'tests': ['tsvgx', 04:49:31 INFO - 'tsvgr_opacity', 04:49:31 INFO - 'tart', 04:49:31 INFO - 'tscrollx', 04:49:31 INFO - 'cart']}, 04:49:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:31 INFO - 'tests': ['tp5o']}, 04:49:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:31 INFO - 'talos_options': ['--e10s'], 04:49:31 INFO - 'tests': ['tp5o']}, 04:49:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:31 INFO - 'talos_options': ['--xperf_path', 04:49:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:31 INFO - 'tests': ['tp5n']}, 04:49:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:31 INFO - 'talos_options': ['--e10s', 04:49:31 INFO - '--xperf_path', 04:49:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 04:49:31 INFO - 'C:/slave/talos-data/talos/xperf.config'], 04:49:31 INFO - 'tests': ['tp5n']}}, 04:49:31 INFO - 'talos.zip': {'path': '', 04:49:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:31 INFO - Running post-action listener: _resource_record_post_action 04:49:31 INFO - ##### 04:49:31 INFO - ##### Running create-virtualenv step. 04:49:31 INFO - ##### 04:49:31 INFO - Running pre-action listener: _resource_record_pre_action 04:49:31 INFO - Running main action method: create_virtualenv 04:49:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:31 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 04:49:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:31 INFO - Using real prefix '/tools/python27' 04:49:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:35 INFO - Installing pip.................done. 04:49:35 INFO - Return code: 0 04:49:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:35 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 0x1022caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9432e02e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227f9f0>, '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 0x101fdecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102249990>, '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.kT1FYdZPae/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.fwZiDRp86a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 04:49:35 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 04:49:35 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 04:49:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kT1FYdZPae/Render', 04:49:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:35 INFO - 'HOME': '/Users/cltbld', 04:49:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:35 INFO - 'LOGNAME': 'cltbld', 04:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:35 INFO - 'MOZ_NO_REMOTE': '1', 04:49:35 INFO - 'NO_EM_RESTART': '1', 04:49:35 INFO - 'PAGER': '/bin/cat', 04:49:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:35 INFO - 'PWD': '/builds/slave/test', 04:49:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:35 INFO - 'SHELL': '/bin/bash', 04:49:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fwZiDRp86a/Listeners', 04:49:35 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 04:49:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:35 INFO - 'USER': 'cltbld', 04:49:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:35 INFO - 'XPC_FLAGS': '0x0', 04:49:35 INFO - 'XPC_SERVICE_NAME': '0', 04:49:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:37 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 04:49:37 INFO - Cleaning up... 04:49:37 INFO - Return code: 0 04:49:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1022caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9432e02e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227f9f0>, '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 0x101fdecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102249990>, '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.kT1FYdZPae/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.fwZiDRp86a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 04:49:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:49:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kT1FYdZPae/Render', 04:49:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:37 INFO - 'HOME': '/Users/cltbld', 04:49:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:37 INFO - 'LOGNAME': 'cltbld', 04:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:37 INFO - 'MOZ_NO_REMOTE': '1', 04:49:37 INFO - 'NO_EM_RESTART': '1', 04:49:37 INFO - 'PAGER': '/bin/cat', 04:49:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:37 INFO - 'PWD': '/builds/slave/test', 04:49:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:37 INFO - 'SHELL': '/bin/bash', 04:49:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fwZiDRp86a/Listeners', 04:49:37 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 04:49:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:37 INFO - 'USER': 'cltbld', 04:49:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:37 INFO - 'XPC_FLAGS': '0x0', 04:49:37 INFO - 'XPC_SERVICE_NAME': '0', 04:49:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:37 INFO - Downloading/unpacking psutil>=0.7.1 04:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:39 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:49:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:39 INFO - Installing collected packages: psutil 04:49:39 INFO - Running setup.py install for psutil 04:49:40 INFO - building 'psutil._psutil_osx' extension 04:49:40 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 04:49:41 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 04:49:41 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 04:49:42 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 04:49:42 INFO - building 'psutil._psutil_posix' extension 04:49:42 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 04:49:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:49:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:49:42 INFO - ^ 04:49:42 INFO - 1 warning generated. 04:49:42 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 04:49:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:42 INFO - Successfully installed psutil 04:49:42 INFO - Cleaning up... 04:49:42 INFO - Return code: 0 04:49:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:42 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 0x1022caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9432e02e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227f9f0>, '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 0x101fdecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102249990>, '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.kT1FYdZPae/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.fwZiDRp86a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 04:49:42 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 04:49:42 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 04:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kT1FYdZPae/Render', 04:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:42 INFO - 'HOME': '/Users/cltbld', 04:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:42 INFO - 'LOGNAME': 'cltbld', 04:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:42 INFO - 'MOZ_NO_REMOTE': '1', 04:49:42 INFO - 'NO_EM_RESTART': '1', 04:49:42 INFO - 'PAGER': '/bin/cat', 04:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:42 INFO - 'PWD': '/builds/slave/test', 04:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:42 INFO - 'SHELL': '/bin/bash', 04:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fwZiDRp86a/Listeners', 04:49:42 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 04:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:42 INFO - 'USER': 'cltbld', 04:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:42 INFO - 'XPC_FLAGS': '0x0', 04:49:42 INFO - 'XPC_SERVICE_NAME': '0', 04:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:49:43 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 04:49:43 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 04:49:43 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 04:49:43 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 04:49:43 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 04:49:43 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 04:49:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:49:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:49:45 INFO - Installing collected packages: mozsystemmonitor 04:49:45 INFO - Running setup.py install for mozsystemmonitor 04:49:45 INFO - Successfully installed mozsystemmonitor 04:49:45 INFO - Cleaning up... 04:49:45 INFO - Return code: 0 04:49:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49:45 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')]} 04:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:45 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')]} 04:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:45 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 0x1022caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9432e02e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227f9f0>, '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 0x101fdecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102249990>, '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.kT1FYdZPae/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.fwZiDRp86a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 04:49:45 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 04:49:45 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 04:49:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kT1FYdZPae/Render', 04:49:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:45 INFO - 'HOME': '/Users/cltbld', 04:49:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:45 INFO - 'LOGNAME': 'cltbld', 04:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:45 INFO - 'MOZ_NO_REMOTE': '1', 04:49:45 INFO - 'NO_EM_RESTART': '1', 04:49:45 INFO - 'PAGER': '/bin/cat', 04:49:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:45 INFO - 'PWD': '/builds/slave/test', 04:49:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:45 INFO - 'SHELL': '/bin/bash', 04:49:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fwZiDRp86a/Listeners', 04:49:45 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 04:49:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:45 INFO - 'USER': 'cltbld', 04:49:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:45 INFO - 'XPC_FLAGS': '0x0', 04:49:45 INFO - 'XPC_SERVICE_NAME': '0', 04:49:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:46 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 04:49:46 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 04:49:46 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 04:49:46 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 04:49:46 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 04:49:46 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 04:49:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:48 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 04:49:48 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 04:49:48 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 04:49:48 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 04:49:48 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 04:49:48 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 04:49:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:49 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 04:49:49 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 04:49:49 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 04:49:49 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 04:49:49 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 04:49:49 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 04:49:49 INFO - Downloading docopt-0.6.1.tar.gz 04:49:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:50 INFO - Running setup.py install for blobuploader 04:49:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:50 INFO - Running setup.py install for requests 04:49:50 INFO - Running setup.py install for docopt 04:49:50 INFO - Successfully installed blobuploader requests docopt 04:49:50 INFO - Cleaning up... 04:49:50 INFO - Return code: 0 04:49:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:50 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 0x1022caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9432e02e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227f9f0>, '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 0x101fdecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102249990>, '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.kT1FYdZPae/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.fwZiDRp86a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 04:49:50 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 04:49:50 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 04:49:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kT1FYdZPae/Render', 04:49:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:51 INFO - 'HOME': '/Users/cltbld', 04:49:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:51 INFO - 'LOGNAME': 'cltbld', 04:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:51 INFO - 'MOZ_NO_REMOTE': '1', 04:49:51 INFO - 'NO_EM_RESTART': '1', 04:49:51 INFO - 'PAGER': '/bin/cat', 04:49:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:51 INFO - 'PWD': '/builds/slave/test', 04:49:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:51 INFO - 'SHELL': '/bin/bash', 04:49:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fwZiDRp86a/Listeners', 04:49:51 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 04:49:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:51 INFO - 'USER': 'cltbld', 04:49:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:51 INFO - 'XPC_FLAGS': '0x0', 04:49:51 INFO - 'XPC_SERVICE_NAME': '0', 04:49:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:51 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-3PHDhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:51 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-1Wl3_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:51 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-YRiSbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:51 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-d4BwZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:51 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-sDpY_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:51 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-EPsWcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:52 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-jCeIGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:52 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-tVhXbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:52 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-QpiUat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:52 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-w6KZKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:52 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-k3dQ2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:52 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-j4UYBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:52 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-bsuaRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:52 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-LYwijT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:53 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-fqx_rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:53 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-rydQbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:53 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-xTW7jZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:49:53 INFO - Running setup.py install for manifestparser 04:49:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:49:53 INFO - Running setup.py install for mozcrash 04:49:53 INFO - Running setup.py install for mozdebug 04:49:53 INFO - Running setup.py install for mozdevice 04:49:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:49:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:49:54 INFO - Running setup.py install for mozfile 04:49:54 INFO - Running setup.py install for mozhttpd 04:49:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:49:54 INFO - Running setup.py install for mozinfo 04:49:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:49:54 INFO - Running setup.py install for mozInstall 04:49:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:49:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:49:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:49:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:49:54 INFO - Running setup.py install for mozleak 04:49:55 INFO - Running setup.py install for mozlog 04:49:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:49:55 INFO - Running setup.py install for moznetwork 04:49:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:49:55 INFO - Running setup.py install for mozprocess 04:49:55 INFO - Running setup.py install for mozprofile 04:49:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:49:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:49:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:49:55 INFO - Running setup.py install for mozrunner 04:49:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:49:56 INFO - Running setup.py install for mozscreenshot 04:49:56 INFO - Running setup.py install for moztest 04:49:56 INFO - Running setup.py install for mozversion 04:49:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:49:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:49:56 INFO - Cleaning up... 04:49:56 INFO - Return code: 0 04:49:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:56 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 0x1022caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9432e02e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227f9f0>, '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 0x101fdecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102249990>, '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.kT1FYdZPae/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.fwZiDRp86a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 04:49:56 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 04:49:56 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 04:49:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kT1FYdZPae/Render', 04:49:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:56 INFO - 'HOME': '/Users/cltbld', 04:49:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:56 INFO - 'LOGNAME': 'cltbld', 04:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:56 INFO - 'MOZ_NO_REMOTE': '1', 04:49:56 INFO - 'NO_EM_RESTART': '1', 04:49:56 INFO - 'PAGER': '/bin/cat', 04:49:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:56 INFO - 'PWD': '/builds/slave/test', 04:49:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:56 INFO - 'SHELL': '/bin/bash', 04:49:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fwZiDRp86a/Listeners', 04:49:56 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 04:49:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:56 INFO - 'USER': 'cltbld', 04:49:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:56 INFO - 'XPC_FLAGS': '0x0', 04:49:56 INFO - 'XPC_SERVICE_NAME': '0', 04:49:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:56 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-Q0fA4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:57 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)) 04:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:57 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-Qc9rJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:57 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)) 04:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:57 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-jBxGOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:57 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)) 04:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:57 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-6Ocyyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 04:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:57 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-JMd8mI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:57 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)) 04:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:57 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-LLgisn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:57 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)) 04:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:57 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-uplKPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 04:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:57 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-Yt84J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:57 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)) 04:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:57 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-oWg56r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:58 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)) 04:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:58 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-hzK5qN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:58 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)) 04:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:58 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-nR7jI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:58 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)) 04:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:58 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-ludCKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:58 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)) 04:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:58 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-K37MZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:58 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)) 04:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:58 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-t1V4k9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:58 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)) 04:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:58 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-Gem2zQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:58 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)) 04:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:58 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-6KKEXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:58 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)) 04:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:58 INFO - Running setup.py (path:/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/pip-kF9_YY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:59 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)) 04:49:59 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)) 04:49:59 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)) 04:49:59 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)) 04:49:59 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:59 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:59 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 04:49:59 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 04:49:59 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 04:49:59 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 04:49:59 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 04:49:59 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 04:50:01 INFO - Downloading blessings-1.5.1.tar.gz 04:50:01 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 04:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:50:01 INFO - Installing collected packages: blessings 04:50:01 INFO - Running setup.py install for blessings 04:50:01 INFO - Successfully installed blessings 04:50:01 INFO - Cleaning up... 04:50:02 INFO - Return code: 0 04:50:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:50:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:02 INFO - Reading from file tmpfile_stdout 04:50:02 INFO - Current package versions: 04:50:02 INFO - blessings == 1.5.1 04:50:02 INFO - blobuploader == 1.2.4 04:50:02 INFO - docopt == 0.6.1 04:50:02 INFO - manifestparser == 1.1 04:50:02 INFO - mozInstall == 1.12 04:50:02 INFO - mozcrash == 0.16 04:50:02 INFO - mozdebug == 0.1 04:50:02 INFO - mozdevice == 0.47 04:50:02 INFO - mozfile == 1.2 04:50:02 INFO - mozhttpd == 0.7 04:50:02 INFO - mozinfo == 0.9 04:50:02 INFO - mozleak == 0.1 04:50:02 INFO - mozlog == 3.0 04:50:02 INFO - moznetwork == 0.27 04:50:02 INFO - mozprocess == 0.22 04:50:02 INFO - mozprofile == 0.27 04:50:02 INFO - mozrunner == 6.11 04:50:02 INFO - mozscreenshot == 0.1 04:50:02 INFO - mozsystemmonitor == 0.0 04:50:02 INFO - moztest == 0.7 04:50:02 INFO - mozversion == 1.4 04:50:02 INFO - psutil == 3.1.1 04:50:02 INFO - requests == 1.2.3 04:50:02 INFO - wsgiref == 0.1.2 04:50:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x1022caa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102337228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9432e02e40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10227f9f0>, '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 0x101fdecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102249990>, '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.kT1FYdZPae/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.fwZiDRp86a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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 04:50:02 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 04:50:02 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 04:50:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kT1FYdZPae/Render', 04:50:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:02 INFO - 'HOME': '/Users/cltbld', 04:50:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:02 INFO - 'LOGNAME': 'cltbld', 04:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:02 INFO - 'MOZ_NO_REMOTE': '1', 04:50:02 INFO - 'NO_EM_RESTART': '1', 04:50:02 INFO - 'PAGER': '/bin/cat', 04:50:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:02 INFO - 'PWD': '/builds/slave/test', 04:50:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:02 INFO - 'SHELL': '/bin/bash', 04:50:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fwZiDRp86a/Listeners', 04:50:02 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 04:50:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:02 INFO - 'USER': 'cltbld', 04:50:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:02 INFO - 'XPC_FLAGS': '0x0', 04:50:02 INFO - 'XPC_SERVICE_NAME': '0', 04:50:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:02 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)) 04:50:02 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)) 04:50:02 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)) 04:50:02 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)) 04:50:02 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)) 04:50:02 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)) 04:50:02 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)) 04:50:02 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)) 04:50:02 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)) 04:50:02 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)) 04:50:02 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)) 04:50:02 INFO - Cleaning up... 04:50:02 INFO - Return code: 0 04:50:02 INFO - Running post-action listener: _resource_record_post_action 04:50:02 INFO - Running post-action listener: _start_resource_monitoring 04:50:02 INFO - Starting resource monitoring. 04:50:02 INFO - ##### 04:50:02 INFO - ##### Running install step. 04:50:02 INFO - ##### 04:50:02 INFO - Running pre-action listener: _resource_record_pre_action 04:50:02 INFO - Running main action method: install 04:50:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:03 INFO - Reading from file tmpfile_stdout 04:50:03 INFO - Detecting whether we're running mozinstall >=1.0... 04:50:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:50:03 INFO - Reading from file tmpfile_stdout 04:50:03 INFO - Output received: 04:50:03 INFO - Usage: mozinstall [options] installer 04:50:03 INFO - Options: 04:50:03 INFO - -h, --help show this help message and exit 04:50:03 INFO - -d DEST, --destination=DEST 04:50:03 INFO - Directory to install application into. [default: 04:50:03 INFO - "/builds/slave/test"] 04:50:03 INFO - --app=APP Application being installed. [default: firefox] 04:50:03 INFO - mkdir: /builds/slave/test/build/application 04:50:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:50:42 INFO - Reading from file tmpfile_stdout 04:50:42 INFO - Output received: 04:50:42 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:50:42 INFO - Running post-action listener: _resource_record_post_action 04:50:42 INFO - ##### 04:50:42 INFO - ##### Running run-tests step. 04:50:42 INFO - ##### 04:50:42 INFO - Running pre-action listener: _resource_record_pre_action 04:50:42 INFO - Running main action method: run_tests 04:50:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:50:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:50:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:50:42 INFO - 2015-11-02 04:50:42.643 screenresolution[1625:7545] starting screenresolution argv=screenresolution get 04:50:42 INFO - 2015-11-02 04:50:42.646 screenresolution[1625:7545] Display 0: 1600x1200x32@60 04:50:42 INFO - 2015-11-02 04:50:42.653 screenresolution[1626:7547] starting screenresolution argv=screenresolution list 04:50:42 INFO - Available Modes on Display 0 04:50:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:50:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:50:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:50:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:50:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:50:42 INFO - Intel HD Graphics 3000: 04:50:42 INFO - Chipset Model: Intel HD Graphics 3000 04:50:42 INFO - Type: GPU 04:50:42 INFO - Bus: Built-In 04:50:42 INFO - VRAM (Total): 512 MB 04:50:42 INFO - VRAM (Dynamic, Max): 10 04:50:42 INFO - Vendor: Intel (0x8086) 04:50:42 INFO - Device ID: 0x0116 04:50:42 INFO - Revision ID: 0x0009 04:50:42 INFO - Displays: 04:50:42 INFO - Display: 04:50:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:50:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:50:42 INFO - Display Serial Number: 1600x1200 60 04:50:42 INFO - Main Display: Yes 04:50:42 INFO - Mirror: Off 04:50:42 INFO - Online: Yes 04:50:42 INFO - Rotation: Supported 04:50:42 INFO - Return code: 0 04:50:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:50:42 INFO - Python 2.7.3 04:50:42 INFO - Return code: 0 04:50:42 INFO - grabbing minidump binary from tooltool 04:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:42 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 0x10227f9f0>, '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 0x101fdecd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102249990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:50:42 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 04:50:42 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 04:50:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:43 INFO - Return code: 0 04:50:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:50:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:50:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:50:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:50:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:50:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0013', '--webServer', 'localhost'] in /builds/slave/test/build 04:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0013 --webServer localhost 04:50:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kT1FYdZPae/Render', 04:50:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:43 INFO - 'HOME': '/Users/cltbld', 04:50:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:43 INFO - 'LOGNAME': 'cltbld', 04:50:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:50:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:43 INFO - 'MOZ_NO_REMOTE': '1', 04:50:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:50:43 INFO - 'NO_EM_RESTART': '1', 04:50:43 INFO - 'PAGER': '/bin/cat', 04:50:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:43 INFO - 'PWD': '/builds/slave/test', 04:50:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:50:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:43 INFO - 'SHELL': '/bin/bash', 04:50:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fwZiDRp86a/Listeners', 04:50:43 INFO - 'TMPDIR': '/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/', 04:50:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:43 INFO - 'USER': 'cltbld', 04:50:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:43 INFO - 'XPC_FLAGS': '0x0', 04:50:43 INFO - 'XPC_SERVICE_NAME': '0', 04:50:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 04:50:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0013', '--webServer', 'localhost'] with output_timeout 3600 04:50:43 INFO - mozversion INFO | application_buildid: 20151102030710 04:50:43 INFO - mozversion INFO | application_changeset: cbb27a88e499604c4bf0be54eb5373a001f8cf62 04:50:43 INFO - mozversion INFO | application_display_name: Nightly 04:50:43 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:43 INFO - mozversion INFO | application_name: Firefox 04:50:43 INFO - mozversion INFO | application_remotingname: firefox 04:50:43 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 04:50:43 INFO - mozversion INFO | application_vendor: Mozilla 04:50:43 INFO - mozversion INFO | application_version: 45.0a1 04:50:43 INFO - mozversion INFO | platform_buildid: 20151102030710 04:50:43 INFO - mozversion INFO | platform_changeset: cbb27a88e499604c4bf0be54eb5373a001f8cf62 04:50:43 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 04:50:43 INFO - mozversion INFO | platform_version: 45.0a1 04:50:43 INFO - 2015-11-02 04:50:43,399 DEBUG : using testdate: 1446468643 04:50:43 INFO - 2015-11-02 04:50:43,399 DEBUG : actual date: 1446468643 04:50:43 INFO - 2015-11-02 04:50:43,493 INFO : starting webserver on 'localhost:49271' 04:50:43 INFO - 2015-11-02 04:50:43,494 INFO : Starting test suite t-yosemite-r5-0013 04:50:43 INFO - 2015-11-02 04:50:43,495 INFO : Starting test dromaeo_css 04:50:43 INFO - 2015-11-02 04:50:43,495 DEBUG : operating with platform_type : mac_ 04:50:43 INFO - 2015-11-02 04:50:43,495 INFO : Initialising browser for dromaeo_css test... 04:50:43 INFO - 2015-11-02 04:50:43,521 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpZ01gbt/profile http://localhost:49271/getInfo.html 04:50:46 INFO - 2015-11-02 04:50:46,536 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:50:46 INFO - 2015-11-02 04:50:46,536 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:50:46 INFO - 2015-11-02 04:50:46,536 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 04:50:46 INFO - 2015-11-02 04:50:46,536 DEBUG : BROWSER_OUTPUT: __metrics 04:50:46 INFO - 2015-11-02 04:50:46,553 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:47 INFO - 2015-11-02 04:50:47,314 INFO : Browser initialized. 04:50:47 INFO - 2015-11-02 04:50:47,314 INFO : Running cycle 1/1 for dromaeo_css test... 04:50:47 INFO - 2015-11-02 04:50:47,315 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpZ01gbt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:50:59 INFO - 2015-11-02 04:50:59,328 DEBUG : BROWSER_OUTPUT: RSS: Main: 221290496 04:50:59 INFO - 2015-11-02 04:50:59,329 DEBUG : BROWSER_OUTPUT: 04:51:51 INFO - 2015-11-02 04:51:51,114 DEBUG : BROWSER_OUTPUT: 1446468711113 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] 04:54:01 INFO - 2015-11-02 04:54:01,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 04:54:02 INFO - 2015-11-02 04:54:02,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 335761408 04:54:02 INFO - 2015-11-02 04:54:02,583 DEBUG : BROWSER_OUTPUT: 04:57:05 INFO - 2015-11-02 04:57:05,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 04:57:05 INFO - 2015-11-02 04:57:05,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 356175872 04:57:05 INFO - 2015-11-02 04:57:05,898 DEBUG : BROWSER_OUTPUT: 05:00:08 INFO - 2015-11-02 05:00:08,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 05:00:08 INFO - 2015-11-02 05:00:08,833 DEBUG : BROWSER_OUTPUT: RSS: Main: 316125184 05:00:08 INFO - 2015-11-02 05:00:08,834 DEBUG : BROWSER_OUTPUT: 05:03:10 INFO - 2015-11-02 05:03:10,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 05:03:11 INFO - 2015-11-02 05:03:11,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 312967168 05:03:11 INFO - 2015-11-02 05:03:11,362 DEBUG : BROWSER_OUTPUT: 05:06:14 INFO - 2015-11-02 05:06:14,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 05:06:15 INFO - 2015-11-02 05:06:15,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 313962496 05:06:15 INFO - 2015-11-02 05:06:15,109 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-11-02 05:09:17,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 05:09:17 INFO - 2015-11-02 05:09:17,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 359514112 05:09:17 INFO - 2015-11-02 05:09:17,938 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-11-02 05:09:17,938 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:09:17 INFO - 2015-11-02 05:09:17,938 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:09:17 INFO - 2015-11-02 05:09:17,938 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:09:17 INFO - 2015-11-02 05:09:17,938 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:09:17 INFO - 2015-11-02 05:09:17,942 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2888.4800735867534;2916.256354629569;2941.4852400829855;2955.2611847038243;3015.110542389995;4610.654200934927;4656.441227052755;4720.669553131283;4812.542808433198;4897.31437598736;4700.882477938053;4702.177119004169;4702.90594188116;4849.878753031176;4892.3884514435695;4412.139632771611;4417.734935903856;4420.845270415536;4434.357018232355;4518.751468669222;4487.19230538503;4500.684952053358;4538.115067561826;4593.448786145667;4600.401947746805;4296.8281268749215;4355.869323920288;4403;4477.3731677565165;4507.729536227836;4371.431713877208;4433.9113217735785;4475.172093162742;4485.125400546862;4546.272596384596;4410.140022695576;4446.444194475691;4453.977730111329;4462.018355961715;4485.035717320791;4683.7892294846815;4714.481407045222;4754.239321708545;4775.689580177277;4807.254875494304;5070.492950704936;5077.593792496591;5089.033083714119;5138.6916784992645;5172.069027575035;5146.356705411824;5166.405863325691;5168.664036837594;5200.323957885451;5278.5249327560705;4684.039771846763;4752.857414277542;4766.6901651392545;4774.4509381420885;4798.136335459616;5230.084735171406;5279.234510995961;5287.762050707727;5328.866778330495;5376.73116344189;5057.949420505822;5071.873203169876;5077.771500282496;5107.565856902131;5186.688798672017;4983.9252411213865;5058.140116180258;5150.587952963754;5168.457311982188;5220.738963051908;5066.265391518283;5127.46161653021;5159.664621799571;5182.352205974254;5195.272661827347;5114.948850511521;5125.359330083739;5177.197534382177;5185.714785686823;5191.143461328914;3863.9806800965816;3999.7800120993043;4026.154507553388;4062.614051665087;4067.7966101694797;3680.4111342185656;3693.4275187346007;3699.667029967316;3742.326381251401;3749.3251214781603;4827.396575428072;4846.36997190363;4850.393700787402;4878.585320247747;4909.901801963941;5053.772580233825;5164.25118357836;5172.741362931838;5234.555062819703;5286.682799031993;4843.273508973612;4884.975575122173;4885.462599114095;4893.02139572087;4904.8773780655765;4609.9308510372375;4612.031473390625;4625.398698169217;4655.4180727409075;4661.813527458864;5098.337216161875;5179.2749015137915;5252.579793616502;5266.605004624746;5327;5209.713465759268;5213.530782229617;5217.2434996925995;5227.529522343008;5277.313949186581;5258.526732594085;5276.472352764847;5301.072859880953;5323.787048518016;5369.328833895763;4937.728424936663;4942.703437793743;5029.823956161516;5125.077486052546;5204.141316682705;5217.556507696737;5225.973870130625;5226.45122262157;5252.947470525246;5270.947290527046;5050.49495050492;5100.846974590768;5107.565856902205;5111.437741848319;5138.434772174983;5016.347874776256;5043.9747801260755;5098.668586541863;5105.795768169231;5176.637635365489;4886.560209581155;4997.550220480174;5010.674306170087;5064.848054558369;5066.4680208577565;5106.029854327666;5132.178851383761;5170.1986192140275;5199.454057324077;5208.5051920067535;4786.210275304675;4832.95167048325;4902.068606964665;4905.460399355997;4978.502149784992 05:09:17 INFO - 2015-11-02 05:09:17,942 DEBUG : BROWSER_OUTPUT: |1;ext.html;501.8569707633324;506.1648280337443;508.2427183496589;520.7084032941552;528.2050513976469;28051.719482805165;28846.423071538557;35697.2860542789;36740.81629591855;36769;38239.23521529568;39158.80420597893;39255.80372098143;39733.40399894004;39762;7416.925830741678;8453.027901791296;8528.914710852874;8547.615357308905;8571.14288571141;7555.282248186413;9974.202063834911;10170.288079834414;10291.897081029168;10341.948290258539;9954.800903981915;10075.596976120947;10167.186625069977;10179.134773544258;10254.794904101913;7573.394128469764;7761.573113478757;10009.69970900874;10075.395476271411;10145.49272536374;9986.600535978552;10005;10048.296619236584;10124.69625911224;10132;35943;36427.4535881962;36610;36811;36941.07647308812;2691.286808995618;2719.986400067987;2735.1006240133056;2747.175847245818;2833.2350265428427;25149.748502514925;25321.100917431268;25349.23952281416;25674;26253.21240362792;2140.176032227588;2154.53677459347;2156.4608847788054;2160.34109596573;2305.8155347572156;240662;241273;241672;241926;242428;50929.74535127375;51632.483675163516;55702.16446753302;56276;56376.43623563794;57782;58777.4122258772;59307.703461482415;59432.10851837226;59588.70205648944;14871.851281487046;15057.096574205583;15071.623209419853;15099.773503397459;15258.923705381401;11547.076233901267;11619.07047436203;11619.88380116205;11631.709207269716;11634.360110193851;16912.57718557046;17683.11584420774;18293.359732409303;18296.17667204979;18309.3591724289;7079.185893622196;7305.817354566072;7311.305425984523;7362.8527429451115;7364.275218169311;829.1666874790917;829.9377546684022;888.1873086126122;981.8036392721484;992.3301771304341;25716.614250786253;25974.74025259761;26230.73769262321;26284;27281.181564553095;888.3825741109866;912.6395073945754;940.8071345374182;961.927855410847;983.9409635421897;13072.869271307356;13264.668383290495;13390.062695611214;13483.325833708275;13544.796828047587;303361;309165;310239;311635;314523;49237.753811230716;49443;49585.75207123941;49644;49701;1241.5716577780652;1248.9437975291135;1260.294235228275;1277.201748906933;1281.0136195129699;22547.88726056359;25038.62442063407;25285.494290114464;25663.486730265664;25802.225933222035;42292.577074228866;42690.78654606707;42704;42782.14435711206;42815;181384;184207;184213.07893460448;185503;249848;24172;28078.2980425491;28783.856080719463;28904.566431503124;28986.13041608755;34758.82620586881;35241.471377928836;35556.82221588876;36162.8191859039;39668.603313966494;31231.531527027568;32150.190671751283;32310;32496.187595310308;32887;29691.703082968892;29864.85067574735;30059.549106762977;30156.54765178568;30201.848990754905;32373.19067023249;32810.67189328076;33239.83380083084;33540.49689254614;33655.32689346249;26116.477670446864;28364.716352837033;28373.43253134967;28633.713662863105;28701.56947645745;21591.892040539697;21737.782622173574;21823.23618673339;21829.126834926425;21858.562828743656 05:09:17 INFO - 2015-11-02 05:09:17,946 DEBUG : BROWSER_OUTPUT: |2;jquery.html;299.57310832064303;308.78076565638395;314.48738556153467;314.64759469394284;314.96377916539603;12872.09895307329;13267.800982985264;15199.544013679593;15758.68482630348;15997.60005999849;10609.469526523662;10868;10968.561257549689;13612.93193534031;15854.365825367;3987.8604248851225;4046.1705350403245;4054.371572406267;4082.448869402622;4089.734167279117;3099;3201.055688571865;3801.258754542865;3822.522184726909;4251.4898212214575;4328.610425061744;4330.718503297291;4362.8909277268;4373.868783936487;4386;4238.982644165409;4298.441202643637;4299.871003869874;4322.438083049199;4361.498427680825;3682.576503702082;3688.815559222055;3711.740178187528;3715.294094122135;3736.7384283099923;11280.717982050432;11781.705457363549;11821.290722556674;12334.444949977273;12442.564510242099;1678.5132311629613;1702;1723.4829551134735;1791.4177892185091;1814.4738025972451;12464.252144871247;12519.624411267676;12656.240625562496;12833.743325133539;13433.66415839612;1586.754053121768;1613.7337339338994;1622.9350825966947;1647.666636745364;1653.84288492593;58260;61122.694386527786;61754.38245617531;61907.38092619061;62110.37889621091;15717.764233536505;15948.76076858848;15996.280167392495;16053;16149.677006459806;22739.545209095726;22788.886055569616;22803.771962280498;22866.199683011015;22942.65586016211;8854.468731876108;9241.168294853496;9293.117153870371;9382.790058698638;9460.24318054554;7652.502587331805;8017.118117007125;8034.276915077671;8122.472039317426;8189.918100818915;7407.962885196077;7438.776836694908;7447.627618619155;7517.8120546985665;7519.323260906544;2878.280429892527;2883.567464880243;2897.6522817261643;2941.794074414813;3017.1853599528445;363.93085313790294;367.514880357925;375.72008853403844;386.63269893601193;401.91358857845705;9872.851907221397;10101.64644237463;10197.13324367437;10303.227257955534;10386.844197337046;399.3550416078013;400.7154920006828;401.54023642928684;406.991860162801;409.7172950664092;5451.073317536028;5718.656880587178;5732.684702341411;5760.942390576124;5797.942020579824;509080;516519;517131;530831;534100;52431;58455.41544584585;60749;61960.380396196364;63932;436.32152003634656;437.08430837395605;437.2915876280446;443.46562392317827;444.0563801920854;9642.228621710106;9926.404415735078;9931.553080111267;10161.237907156845;10194.796104077728;30096.548551771302;31550;31557.211069723442;32172.678273217905;32248.677513224568;41455.37816932809;42278.365824513276;42708.78645606877;42990.57009429991;43602.473913412876;5523.502884740393;5637.887242255214;5686.800961966312;5691.601587888974;5708.885822283614;10405.739856503647;10491.527881245209;10967.177461690564;10984.615538456115;10995.780084398428;9207.079292070739;9407.717768466957;9418.10527999839;9431.481268530297;9463.668771592962;8668.133186681282;8944.552772361487;9013.549322533978;9064.90935090667;9088.636454541744;9214.2628589714;9359.67241146584;9475.52622368865;9559.283053770856;9565.234781217347;5404.83785486436;5548.778048878161;5601.355844077821;5686.374498805046;5707.714614269187;8969.50667713256;9123.954380228322;9255.861162082709;9255.953720231355;9308.348415610842 05:09:17 INFO - 2015-11-02 05:09:17,947 DEBUG : BROWSER_OUTPUT: |3;mootools.html;779.9649015794296;1291.6383412644464;1514.4472267622314;1525.710115078135;1639.377036726044;6281.937180628192;6510.902336464951;7085.751998680047;7087.610181440019;7183.353498185163;6885.277045910182;7038.331358520945;7043.225245223021;7096.183938847034;7108.0759501264765;1772.2290803500518;1805.873588848781;1971.1721077147597;1976.6145601607693;2003.108616665577;2025.3518873960338;2082.9895850520725;2087.5720477302116;2099.7060411542398;2102.905369258387;1967;2000.2299114840746;2006.5585571174317;2024.564718585504;2031.8069783370556;1960.255103060842;1987.3044434447972;2015.4659015360867;2019.8889061101634;2035.765886923008;2008.0361426515356;2008.979910200894;2009.768876579183;2035.562354093862;2038.816506514406;6921.065656136458;7017.47368947331;7021.89467157993;7085.82285442868;7114.715411383539;4216.7259128156575;4310.52584215736;4317.589828966243;4341;4382.846600368972;2513.0952856971476;2529.8861551230057;2594.7664710175986;2611.2688447234805;2626.2383908666466;692.3595674001529;713.6717110129347;773.6750564762813;789.9486533375369;822.0587427395658;9130.863037054449;9195.264378849675;9242.260619150518;9242.399244049115;9259.722208333827;3952.288588054178;4027.7583344999393;4049.311617025113;4050.736702114353;4080.81636326366;8152.328772601602;8218.876716849252;8224.054233763074;8233.217844304781;8248.8350232995;4341.717788343811;4433.955660443355;4486.282194848808;4491.3487544306545;4495.25828238337;4054.108096218827;4059.4316795648633;4061.7156799024374;4104.835806567764;4105.261053010427;3315.4251730427854;3375.2236985493473;3425.6403077676487;3460.3425349183576;3471.5139880416764;1062.3148069495132;1084.5065495199665;1105.789899919013;1106.397013627575;1107.241539545414;901.4185850126631;922.4419226368085;922.7231830450838;1024.288119756762;1081.0378762901025;6690.19717633887;6720.831979200461;6732.562383445061;6750.864982700318;6778.288279730656;419.4421419512042;423.9894002649897;424.2999051564881;424.73454091193;425.9936100958488;5167.948320516747;5343.5190832824455;5353.330833645794;5405.054115529767;5412.621116521885;7490.588017659081;8034.397420193509;8188.2630563249595;8284.08875023747;8297.128801475757;7298.96350518244;8197.46716463428;8201.630926608317;8314.334853211729;8339.45793523419;6421.197350331208;6553.180852393451;6592.472602191813;6619.966900165468;6623.039659249382;6445.2265728112925;6623;6702.899456508254;6712.295209002984;6726.495512836655;7292.124945006421;7400.592967386845;7520.699172033057;7584.5070070445245;7623.733169339046;7345.118585769528;7570.786907214024;7654.885176722242;7675.53946763196;7742.722450795555;6189.659568723763;6231.096491008869;6234.781782637586;6298.874022519615;6314.052892066226;6592.80221593353;6751.223609284799;6772.322767723188;6798.218204906499;6888.138982627172;6296.412822548727;6354.3963323484195;6370;6460.192475940507;6508.056331831953;6288.308286088618;6291.528135389955;6297.622142671455;6323.304436512072;6409.839754006187;6426.775062872777;6440.710168042356;6459.61242325462;6489.221293444817;6570.934290657224;5894;5902.409759024235;5921.970390148022;5945.286565612154;5965.582409231312;5976.432238937294;5988.910166347421;6023.186869772525;6029.457348838626;6040 05:09:17 INFO - 2015-11-02 05:09:17,950 DEBUG : BROWSER_OUTPUT: |4;prototype.html;287.9064304101167;297.2138693156601;298.1740578597286;302.9212404774759;303.9559263906732;5354.437784032674;5489.560835133179;5512.366077901042;5530.889382212354;5565.9443405565935;5451.127819548873;5481.862953426166;5482.451754824516;5491.807786727465;5497.47773961473;4227.556106608808;4239.512456067546;4244.872653820375;4295.720778149418;4296;4248.2140803951215;4249.638780703628;4254.4469219001485;4257.574242575749;4260.595243451867;3980.094671683457;4036.2331157080207;4205.03284244624;4208.158368326332;4279.358096285567;4214.536400995873;4231.978840105795;4232.195882782262;4249.6387807036435;4262.147570485915;3654.488371627948;3661.505696730934;3663.1757854482794;3678.4114541673202;3690.280395322913;5178.896422071575;5229.477052294778;5267.183586544092;5303.337082864642;5382.381026182;4705.458872229703;4705.811767529295;4723.220668589679;4743.691660042086;4745.264484004984;5723.08430651098;5735.713214339266;5757.740901659394;5761.164631128463;5765.654060756368;3937.8621748238675;3976.224636195943;3987.943195053313;3992.061865461614;4015.578364271768;5768.625039372428;5906.82279531619;6076.939230607726;6080.787172448987;6100.847478813021;3900.395438707005;3965.306071437487;3965.325894597925;3984.8007599619905;4036.0515278909434;3999.140184860269;4091.3862920562156;4127.2570937230985;4133.1940271647345;4139.834406623701;4718.88202794926;4728.787204575802;4758.5241475852135;4762.571368576845;4791.5687588117235;5592.888142237214;5747.511461525817;5748.425157484302;5752.25220721312;5798.855028624318;1486.4500134950138;1488.3971991343524;1497.311236831048;1507.1861194954602;1507.7711664993215;974.4737841565617;976.3409698453515;978.554757585297;1001.3891526169031;1001.4391940513336;5472.72636368188;5483.862903427446;5483.862903427446;5501.944980550224;5507.9449205507435;5932.377100404396;5976.551758618034;6010.008348622516;6014.909776353358;6034.456898879034;5475.972620136874;5478.123500239943;5484.643498172606;5488.56091512678;5490.423505531941;3220.5169224616493;3305.3554556861664;3316.751243656687;3328.184594774296;3339.699427051577;6095.756169753249;6105.114758360101;6107.267127944675;6107.480864126599;6119;6157.138000679908;6167.444929956326;6171.105189747462;6180.289266734293;6189;5861.736221870026;6056.727447264883;6068.089786531968;6086.756529738761;6101.115338275925;6002.219711437485;6005.939940600713;6011.489023433057;6019.819405417845;6032.638041717511;5868.970655146697;5880.470757631833;5911.940880591139;5912.231409916683;5913.793017244376;5733.913991290051;6061.121137435135;6075.696215189311;6090.695465226632;6102.115193297036;3818.560865500392;3904.2386734586485;3945.763254204757;3947.4276229947072;3949.1311911379453;5808.30300363959;5810.564207684356;5855.443732845373;6001.639901605918;6025.276966764016;5803.65178089316;5853.385394533683;5853.882922341614;5856;5873.794417195549;5700.515456186271;5816.592838501433;5819.854503637443;5851.473367396955;5860.736266867916;5650.35020972577;5682.488576028178;5689.573282003784;5690.118031705092;5690.800821971211;5800.9848276552275;5806.2451881255165;5813.6221145625395;5832.445917637818;5837.241158649348;5606.467385598362;5698.173764803997;5704.629199102211;5712.400197979152;5731.910936921971 05:09:17 INFO - 2015-11-02 05:09:17,952 DEBUG : BROWSER_OUTPUT: |5;yui.html;621.1831441654224;683.9076724642175;689.2452764223174;696.1228851646927;698.5963571772342;11714.062874970003;11965.581204657828;12014.399280035996;12016.49793775778;12077.698057548565;11695.473703683334;12100.757984840298;12159.756804863897;12180.634580962564;12190.451429685663;631.4664108828033;640.8846407646622;651.1632552170462;803.0804728585766;829.6473998550622;817.8691409374501;820.831729495452;826.0417915218347;829.0590180145518;835.3442547600135;836.4186890111375;859.7162936231028;859.9054104048549;862.4092496639822;865.7575878753928;654.6170490263202;667.3626686514367;807.116207752516;855.153398135841;857.3569822633025;631.8420394901275;633.1926793338484;633.2590868683651;634.9777757778455;642.1812189458432;12178.81731774024;12193.45129469176;12215.572454964122;12258.019358451302;12313.815292770616;10074.345167564084;10120.240981926385;10416.42709650969;10637.46812659364;10842.945785271102;8131.471454355507;8175.059868115124;8296.004122730508;8334.913616719728;8545.2309292164;2954.497735384968;3010.9698903011126;3017.0647099399257;3080;3082.6317956553257;43002.1399572013;43031.56968430338;43143.35284970728;43306;43335.78332108351;6082.817515474543;6603.669816509156;8097.109317975018;8137.552434616153;8359.247667709935;10835.458227088615;10902.5093870776;10903.563857445772;10916.01755841978;10918.181136414642;5375.247465354853;5519.834404967857;5558.416366281563;5574.749136288796;5770.826875193751;2910.9854450728035;3149.543316219181;3246.204679853451;3308.338332333543;3389.74576906733;2488.639147323628;2495.6506089147533;2508.184839927031;2516.3709072731817;2523.0916869926814;379.4194881830803;391.6181722820227;415.9812808423628;433.83731100837184;436.68776824570585;425.7488082031616;516.5015759791819;539.7328322480397;546.4344403542315;557.4871118570925;6877.9656101720175;6910.997905303703;7293.088363954505;7314.634268286564;7344.926550734531;427.79465856389106;439.05164843936944;455.5057762327845;498.7830293822199;550.9531689806412;3297.291082417292;3343.7993720376367;3390.6100798408006;3392.5928888533535;3432.811195384228;52495.212571811455;52778.472215278125;52863.73568132212;52923.206151907754;52935.73532132392;47052.7647361761;47480;47694.761526192146;48024;48577.27134092992;41541;42437.36343954843;42617.78691106525;42977.57022429798;43565.34651980159;6757.797266082025;6951.9652401739695;7031.296870312928;7064.222935476991;7176.820579485555;32077.67922320747;32364.83817580897;33226;33360.332793343514;33389.33221335511;43298.35052474152;43329.56670433381;44078.55921440745;44414.77792611016;44419;5774.884502310014;6037.818865434044;6190.7214175363115;6193.318734939243;6295.18162638854;9157.450552966844;9177.77055573616;9196.540172991457;9305.255579553756;9311.301652376234;8595.31237501011;8596.140385961604;8669.30645548342;8805.911940880509;9299.488528131018;8388.538471829354;8622.26710729595;8690.348223883107;8800.295976321751;8820.5589720515;8238.176182381714;8250.127178239065;8362.289205417364;8590.82818343642;8727.170918762708;7177.210506844347;7299.671514781741;7313.926860731324;7684.423668224794;7946.443748937519;7271.963640181765;7341.926580734338;7481.177070522347;7630.618469076635;7644.197359277196 05:09:17 INFO - 2015-11-02 05:09:17,952 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:09:17 INFO - 2015-11-02 05:09:17,952 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:09:17 INFO - 2015-11-02 05:09:17,952 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 05:09:17 INFO - 2015-11-02 05:09:17,952 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:09:17 INFO - 2015-11-02 05:09:17,952 DEBUG : BROWSER_OUTPUT: __startTimestamp1446469757937__endTimestamp 05:09:17 INFO - 2015-11-02 05:09:17,953 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-11-02 05:09:17,953 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:09:17 INFO - 2015-11-02 05:09:17,953 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:09:17 INFO - 2015-11-02 05:09:17,953 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-11-02 05:09:17,953 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4816.63 Median:4978.50 stddev:503.11 (10.1%) stddev-sans-first:481.37 05:09:17 INFO - 2015-11-02 05:09:17,953 DEBUG : BROWSER_OUTPUT: Values: 2888.5 2916.3 2941.5 2955.3 3015.1 4610.7 4656.4 4720.7 4812.5 4897.3 4700.9 4702.2 4702.9 4849.9 4892.4 4412.1 4417.7 4420.8 4434.4 4518.8 4487.2 4500.7 4538.1 4593.4 4600.4 4296.8 4355.9 4403.0 4477.4 4507.7 4371.4 4433.9 4475.2 4485.1 4546.3 4410.1 4446.4 4454.0 4462.0 4485.0 4683.8 4714.5 4754.2 4775.7 4807.3 5070.5 5077.6 5089.0 5138.7 5172.1 5146.4 5166.4 5168.7 5200.3 5278.5 4684.0 4752.9 4766.7 4774.5 4798.1 5230.1 5279.2 5287.8 5328.9 5376.7 5057.9 5071.9 5077.8 5107.6 5186.7 4983.9 5058.1 5150.6 5168.5 5220.7 5066.3 5127.5 5159.7 5182.4 5195.3 5114.9 5125.4 5177.2 5185.7 5191.1 3864.0 3999.8 4026.2 4062.6 4067.8 3680.4 3693.4 3699.7 3742.3 3749.3 4827.4 4846.4 4850.4 4878.6 4909.9 5053.8 5164.3 5172.7 5234.6 5286.7 4843.3 4885.0 4885.5 4893.0 4904.9 4609.9 4612.0 4625.4 4655.4 4661.8 5098.3 5179.3 5252.6 5266.6 5327.0 5209.7 5213.5 5217.2 5227.5 5277.3 5258.5 5276.5 5301.1 5323.8 5369.3 4937.7 4942.7 5029.8 5125.1 5204.1 5217.6 5226.0 5226.5 5252.9 5270.9 5050.5 5100.8 5107.6 5111.4 5138.4 5016.3 5044.0 5098.7 5105.8 5176.6 4886.6 4997.6 5010.7 5064.8 5066.5 5106.0 5132.2 5170.2 5199.5 5208.5 4786.2 4833.0 4902.1 4905.5 4978.5 05:09:17 INFO - 2015-11-02 05:09:17,954 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-11-02 05:09:17,955 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40824.83 Median:29338.92 stddev:66494.69 (226.6%) stddev-sans-first:66612.30 05:09:17 INFO - 2015-11-02 05:09:17,956 DEBUG : BROWSER_OUTPUT: Values: 501.9 506.2 508.2 520.7 528.2 28051.7 28846.4 35697.3 36740.8 36769.0 38239.2 39158.8 39255.8 39733.4 39762.0 7416.9 8453.0 8528.9 8547.6 8571.1 7555.3 9974.2 10170.3 10291.9 10341.9 9954.8 10075.6 10167.2 10179.1 10254.8 7573.4 7761.6 10009.7 10075.4 10145.5 9986.6 10005.0 10048.3 10124.7 10132.0 35943.0 36427.5 36610.0 36811.0 36941.1 2691.3 2720.0 2735.1 2747.2 2833.2 25149.7 25321.1 25349.2 25674.0 26253.2 2140.2 2154.5 2156.5 2160.3 2305.8 240662.0 241273.0 241672.0 241926.0 242428.0 50929.7 51632.5 55702.2 56276.0 56376.4 57782.0 58777.4 59307.7 59432.1 59588.7 14871.9 15057.1 15071.6 15099.8 15258.9 11547.1 11619.1 11619.9 11631.7 11634.4 16912.6 17683.1 18293.4 18296.2 18309.4 7079.2 7305.8 7311.3 7362.9 7364.3 829.2 829.9 888.2 981.8 992.3 25716.6 25974.7 26230.7 26284.0 27281.2 888.4 912.6 940.8 961.9 983.9 13072.9 13264.7 13390.1 13483.3 13544.8 303361.0 309165.0 310239.0 311635.0 314523.0 49237.8 49443.0 49585.8 49644.0 49701.0 1241.6 1248.9 1260.3 1277.2 1281.0 22547.9 25038.6 25285.5 25663.5 25802.2 42292.6 42690.8 42704.0 42782.1 42815.0 181384.0 184207.0 184213.1 185503.0 249848.0 24172.0 28078.3 28783.9 28904.6 28986.1 34758.8 35241.5 35556.8 36162.8 39668.6 31231.5 32150.2 32310.0 32496.2 32887.0 29691.7 29864.9 30059.5 30156.5 30201.8 32373.2 32810.7 33239.8 33540.5 33655.3 26116.5 28364.7 28373.4 28633.7 28701.6 21591.9 21737.8 21823.2 21829.1 21858.6 05:09:17 INFO - 2015-11-02 05:09:17,956 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-11-02 05:09:17,956 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26225.43 Median:41866.87 stddev:85209.46 (203.5%) stddev-sans-first:85426.25 05:09:17 INFO - 2015-11-02 05:09:17,958 DEBUG : BROWSER_OUTPUT: Values: 299.6 308.8 314.5 314.6 315.0 12872.1 13267.8 15199.5 15758.7 15997.6 10609.5 10868.0 10968.6 13612.9 15854.4 3987.9 4046.2 4054.4 4082.4 4089.7 3099.0 3201.1 3801.3 3822.5 4251.5 4328.6 4330.7 4362.9 4373.9 4386.0 4239.0 4298.4 4299.9 4322.4 4361.5 3682.6 3688.8 3711.7 3715.3 3736.7 11280.7 11781.7 11821.3 12334.4 12442.6 1678.5 1702.0 1723.5 1791.4 1814.5 12464.3 12519.6 12656.2 12833.7 13433.7 1586.8 1613.7 1622.9 1647.7 1653.8 58260.0 61122.7 61754.4 61907.4 62110.4 15717.8 15948.8 15996.3 16053.0 16149.7 22739.5 22788.9 22803.8 22866.2 22942.7 8854.5 9241.2 9293.1 9382.8 9460.2 7652.5 8017.1 8034.3 8122.5 8189.9 7408.0 7438.8 7447.6 7517.8 7519.3 2878.3 2883.6 2897.7 2941.8 3017.2 363.9 367.5 375.7 386.6 401.9 9872.9 10101.6 10197.1 10303.2 10386.8 399.4 400.7 401.5 407.0 409.7 5451.1 5718.7 5732.7 5760.9 5797.9 509080.0 516519.0 517131.0 530831.0 534100.0 52431.0 58455.4 60749.0 61960.4 63932.0 436.3 437.1 437.3 443.5 444.1 9642.2 9926.4 9931.6 10161.2 10194.8 30096.5 31550.0 31557.2 32172.7 32248.7 41455.4 42278.4 42708.8 42990.6 43602.5 5523.5 5637.9 5686.8 5691.6 5708.9 10405.7 10491.5 10967.2 10984.6 10995.8 9207.1 9407.7 9418.1 9431.5 9463.7 8668.1 8944.6 9013.5 9064.9 9088.6 9214.3 9359.7 9475.5 9559.3 9565.2 5404.8 5548.8 5601.4 5686.4 5707.7 8969.5 9124.0 9255.9 9256.0 9308.3 05:09:17 INFO - 2015-11-02 05:09:17,958 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-11-02 05:09:17,958 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4900.84 Median:6289.92 stddev:2545.71 (40.5%) stddev-sans-first:2533.99 05:09:17 INFO - 2015-11-02 05:09:17,958 DEBUG : BROWSER_OUTPUT: Values: 780.0 1291.6 1514.4 1525.7 1639.4 6281.9 6510.9 7085.8 7087.6 7183.4 6885.3 7038.3 7043.2 7096.2 7108.1 1772.2 1805.9 1971.2 1976.6 2003.1 2025.4 2083.0 2087.6 2099.7 2102.9 1967.0 2000.2 2006.6 2024.6 2031.8 1960.3 1987.3 2015.5 2019.9 2035.8 2008.0 2009.0 2009.8 2035.6 2038.8 6921.1 7017.5 7021.9 7085.8 7114.7 4216.7 4310.5 4317.6 4341.0 4382.8 2513.1 2529.9 2594.8 2611.3 2626.2 692.4 713.7 773.7 789.9 822.1 9130.9 9195.3 9242.3 9242.4 9259.7 3952.3 4027.8 4049.3 4050.7 4080.8 8152.3 8218.9 8224.1 8233.2 8248.8 4341.7 4434.0 4486.3 4491.3 4495.3 4054.1 4059.4 4061.7 4104.8 4105.3 3315.4 3375.2 3425.6 3460.3 3471.5 1062.3 1084.5 1105.8 1106.4 1107.2 901.4 922.4 922.7 1024.3 1081.0 6690.2 6720.8 6732.6 6750.9 6778.3 419.4 424.0 424.3 424.7 426.0 5167.9 5343.5 5353.3 5405.1 5412.6 7490.6 8034.4 8188.3 8284.1 8297.1 7299.0 8197.5 8201.6 8314.3 8339.5 6421.2 6553.2 6592.5 6620.0 6623.0 6445.2 6623.0 6702.9 6712.3 6726.5 7292.1 7400.6 7520.7 7584.5 7623.7 7345.1 7570.8 7654.9 7675.5 7742.7 6189.7 6231.1 6234.8 6298.9 6314.1 6592.8 6751.2 6772.3 6798.2 6888.1 6296.4 6354.4 6370.0 6460.2 6508.1 6288.3 6291.5 6297.6 6323.3 6409.8 6426.8 6440.7 6459.6 6489.2 6570.9 5894.0 5902.4 5922.0 5945.3 5965.6 5976.4 5988.9 6023.2 6029.5 6040.0 05:09:17 INFO - 2015-11-02 05:09:17,958 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-11-02 05:09:17,959 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4826.40 Median:5494.64 stddev:1449.36 (26.4%) stddev-sans-first:1412.83 05:09:17 INFO - 2015-11-02 05:09:17,960 DEBUG : BROWSER_OUTPUT: Values: 287.9 297.2 298.2 302.9 304.0 5354.4 5489.6 5512.4 5530.9 5565.9 5451.1 5481.9 5482.5 5491.8 5497.5 4227.6 4239.5 4244.9 4295.7 4296.0 4248.2 4249.6 4254.4 4257.6 4260.6 3980.1 4036.2 4205.0 4208.2 4279.4 4214.5 4232.0 4232.2 4249.6 4262.1 3654.5 3661.5 3663.2 3678.4 3690.3 5178.9 5229.5 5267.2 5303.3 5382.4 4705.5 4705.8 4723.2 4743.7 4745.3 5723.1 5735.7 5757.7 5761.2 5765.7 3937.9 3976.2 3987.9 3992.1 4015.6 5768.6 5906.8 6076.9 6080.8 6100.8 3900.4 3965.3 3965.3 3984.8 4036.1 3999.1 4091.4 4127.3 4133.2 4139.8 4718.9 4728.8 4758.5 4762.6 4791.6 5592.9 5747.5 5748.4 5752.3 5798.9 1486.5 1488.4 1497.3 1507.2 1507.8 974.5 976.3 978.6 1001.4 1001.4 5472.7 5483.9 5483.9 5501.9 5507.9 5932.4 5976.6 6010.0 6014.9 6034.5 5476.0 5478.1 5484.6 5488.6 5490.4 3220.5 3305.4 3316.8 3328.2 3339.7 6095.8 6105.1 6107.3 6107.5 6119.0 6157.1 6167.4 6171.1 6180.3 6189.0 5861.7 6056.7 6068.1 6086.8 6101.1 6002.2 6005.9 6011.5 6019.8 6032.6 5869.0 5880.5 5911.9 5912.2 5913.8 5733.9 6061.1 6075.7 6090.7 6102.1 3818.6 3904.2 3945.8 3947.4 3949.1 5808.3 5810.6 5855.4 6001.6 6025.3 5803.7 5853.4 5853.9 5856.0 5873.8 5700.5 5816.6 5819.9 5851.5 5860.7 5650.4 5682.5 5689.6 5690.1 5690.8 5801.0 5806.2 5813.6 5832.4 5837.2 5606.5 5698.2 5704.6 5712.4 5731.9 05:09:17 INFO - 2015-11-02 05:09:17,960 DEBUG : BROWSER_OUTPUT: 05:09:17 INFO - 2015-11-02 05:09:17,960 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11953.82 Median:5539.13 stddev:14983.29 (270.5%) stddev-sans-first:15001.16 05:09:17 INFO - 2015-11-02 05:09:17,961 DEBUG : BROWSER_OUTPUT: Values: 621.2 683.9 689.2 696.1 698.6 11714.1 11965.6 12014.4 12016.5 12077.7 11695.5 12100.8 12159.8 12180.6 12190.5 631.5 640.9 651.2 803.1 829.6 817.9 820.8 826.0 829.1 835.3 836.4 859.7 859.9 862.4 865.8 654.6 667.4 807.1 855.2 857.4 631.8 633.2 633.3 635.0 642.2 12178.8 12193.5 12215.6 12258.0 12313.8 10074.3 10120.2 10416.4 10637.5 10842.9 8131.5 8175.1 8296.0 8334.9 8545.2 2954.5 3011.0 3017.1 3080.0 3082.6 43002.1 43031.6 43143.4 43306.0 43335.8 6082.8 6603.7 8097.1 8137.6 8359.2 10835.5 10902.5 10903.6 10916.0 10918.2 5375.2 5519.8 5558.4 5574.7 5770.8 2911.0 3149.5 3246.2 3308.3 3389.7 2488.6 2495.7 2508.2 2516.4 2523.1 379.4 391.6 416.0 433.8 436.7 425.7 516.5 539.7 546.4 557.5 6878.0 6911.0 7293.1 7314.6 7344.9 427.8 439.1 455.5 498.8 551.0 3297.3 3343.8 3390.6 3392.6 3432.8 52495.2 52778.5 52863.7 52923.2 52935.7 47052.8 47480.0 47694.8 48024.0 48577.3 41541.0 42437.4 42617.8 42977.6 43565.3 6757.8 6952.0 7031.3 7064.2 7176.8 32077.7 32364.8 33226.0 33360.3 33389.3 43298.4 43329.6 44078.6 44414.8 44419.0 5774.9 6037.8 6190.7 6193.3 6295.2 9157.5 9177.8 9196.5 9305.3 9311.3 8595.3 8596.1 8669.3 8805.9 9299.5 8388.5 8622.3 8690.3 8800.3 8820.6 8238.2 8250.1 8362.3 8590.8 8727.2 7177.2 7299.7 7313.9 7684.4 7946.4 7272.0 7341.9 7481.2 7630.6 7644.2 05:09:17 INFO - 2015-11-02 05:09:17,961 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:09:17 INFO - 2015-11-02 05:09:17,962 DEBUG : BROWSER_OUTPUT: 05:09:18 INFO - 2015-11-02 05:09:18,632 INFO : Browser exited with error code: 0 05:09:18 INFO - 2015-11-02 05:09:18,662 INFO : Completed test dromaeo_css (00:18:35) 05:09:18 INFO - 2015-11-02 05:09:18,663 INFO : Starting test kraken 05:09:18 INFO - 2015-11-02 05:09:18,663 DEBUG : operating with platform_type : mac_ 05:09:18 INFO - 2015-11-02 05:09:18,663 INFO : Initialising browser for kraken test... 05:09:18 INFO - 2015-11-02 05:09:18,677 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpm9Grdo/profile http://localhost:49271/getInfo.html 05:09:21 INFO - 2015-11-02 05:09:21,052 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:09:21 INFO - 2015-11-02 05:09:21,053 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:09:21 INFO - 2015-11-02 05:09:21,053 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:09:21 INFO - 2015-11-02 05:09:21,053 DEBUG : BROWSER_OUTPUT: __metrics 05:09:21 INFO - 2015-11-02 05:09:21,069 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:21 INFO - 2015-11-02 05:09:21,809 INFO : Browser initialized. 05:09:21 INFO - 2015-11-02 05:09:21,810 INFO : Running cycle 1/1 for kraken test... 05:09:21 INFO - 2015-11-02 05:09:21,810 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpm9Grdo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:09:33 INFO - 2015-11-02 05:09:33,767 DEBUG : BROWSER_OUTPUT: RSS: Main: 220839936 05:09:33 INFO - 2015-11-02 05:09:33,767 DEBUG : BROWSER_OUTPUT: 05:09:36 INFO - 2015-11-02 05:09:36,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 05:09:37 INFO - 2015-11-02 05:09:37,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 278355968 05:09:37 INFO - 2015-11-02 05:09:37,021 DEBUG : BROWSER_OUTPUT: 05:09:39 INFO - 2015-11-02 05:09:39,883 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 05:09:40 INFO - 2015-11-02 05:09:40,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 291790848 05:09:40 INFO - 2015-11-02 05:09:40,476 DEBUG : BROWSER_OUTPUT: 05:09:43 INFO - 2015-11-02 05:09:43,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 05:09:44 INFO - 2015-11-02 05:09:44,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 273162240 05:09:44 INFO - 2015-11-02 05:09:44,231 DEBUG : BROWSER_OUTPUT: 05:09:46 INFO - 2015-11-02 05:09:46,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 05:09:46 INFO - 2015-11-02 05:09:46,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 274173952 05:09:46 INFO - 2015-11-02 05:09:46,961 DEBUG : BROWSER_OUTPUT: 05:09:49 INFO - 2015-11-02 05:09:49,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:49 INFO - 2015-11-02 05:09:49,899 DEBUG : BROWSER_OUTPUT: RSS: Main: 276307968 05:09:49 INFO - 2015-11-02 05:09:49,899 DEBUG : BROWSER_OUTPUT: 05:09:53 INFO - 2015-11-02 05:09:53,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:53 INFO - 2015-11-02 05:09:53,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 276197376 05:09:53 INFO - 2015-11-02 05:09:53,808 DEBUG : BROWSER_OUTPUT: 05:09:57 INFO - 2015-11-02 05:09:57,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:57 INFO - 2015-11-02 05:09:57,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 277131264 05:09:57 INFO - 2015-11-02 05:09:57,800 DEBUG : BROWSER_OUTPUT: 05:10:00 INFO - 2015-11-02 05:10:00,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 05:10:01 INFO - 2015-11-02 05:10:01,515 DEBUG : BROWSER_OUTPUT: RSS: Main: 276606976 05:10:01 INFO - 2015-11-02 05:10:01,515 DEBUG : BROWSER_OUTPUT: 05:10:03 INFO - 2015-11-02 05:10:03,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:10:03 INFO - 2015-11-02 05:10:03,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 312287232 05:10:03 INFO - 2015-11-02 05:10:03,737 DEBUG : BROWSER_OUTPUT: 05:10:05 INFO - 2015-11-02 05:10:05,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:10:06 INFO - 2015-11-02 05:10:06,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 308506624 05:10:06 INFO - 2015-11-02 05:10:06,289 DEBUG : BROWSER_OUTPUT: 05:10:08 INFO - 2015-11-02 05:10:08,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:10:09 INFO - 2015-11-02 05:10:09,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 319152128 05:10:09 INFO - 2015-11-02 05:10:09,132 DEBUG : BROWSER_OUTPUT: 05:10:11 INFO - 2015-11-02 05:10:11,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:10:12 INFO - 2015-11-02 05:10:12,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 321830912 05:10:12 INFO - 2015-11-02 05:10:12,526 DEBUG : BROWSER_OUTPUT: 05:10:15 INFO - 2015-11-02 05:10:15,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:10:15 INFO - 2015-11-02 05:10:15,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 322035712 05:10:15 INFO - 2015-11-02 05:10:15,930 DEBUG : BROWSER_OUTPUT: 05:10:17 INFO - 2015-11-02 05:10:17,774 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 05:10:18 INFO - 2015-11-02 05:10:18,034 DEBUG : BROWSER_OUTPUT: RSS: Main: 380391424 05:10:18 INFO - 2015-11-02 05:10:18,034 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,034 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:10:18 INFO - 2015-11-02 05:10:18,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:10:18 INFO - 2015-11-02 05:10:18,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:10:18 INFO - 2015-11-02 05:10:18,034 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:10:18 INFO - 2015-11-02 05:10:18,034 DEBUG : BROWSER_OUTPUT: |0;ai-astar;106;109;105;112;108;109;106;121;122;121 05:10:18 INFO - 2015-11-02 05:10:18,035 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;171;145;175;188;144;167;163;141;179;142 05:10:18 INFO - 2015-11-02 05:10:18,035 DEBUG : BROWSER_OUTPUT: |2;audio-dft;173;180;181;181;182;178;173;180;179;181 05:10:18 INFO - 2015-11-02 05:10:18,035 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;90;99;98;79;76;78;92;93;74 05:10:18 INFO - 2015-11-02 05:10:18,035 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;105;106;150;100;100;100;150;103;100;149 05:10:18 INFO - 2015-11-02 05:10:18,035 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;129;137;135;136;129;129;136;135;135;135 05:10:18 INFO - 2015-11-02 05:10:18,035 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;141;141;143;141;140;141;141;141;141;141 05:10:18 INFO - 2015-11-02 05:10:18,035 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;111;114;118;117;114;113;113;119;114;111 05:10:18 INFO - 2015-11-02 05:10:18,036 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;62;64;63;65;64;74;66;68 05:10:18 INFO - 2015-11-02 05:10:18,036 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;74;75;76;76;75;76;75;76 05:10:18 INFO - 2015-11-02 05:10:18,036 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;97;97;101;101;99;97;97;96;99 05:10:18 INFO - 2015-11-02 05:10:18,036 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;147;144;156;144;147;147;135;152;145;147 05:10:18 INFO - 2015-11-02 05:10:18,036 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;161;171;178;165;166;165;165;170;169;165 05:10:18 INFO - 2015-11-02 05:10:18,036 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;76;78;80;80;82;83;84;80;79 05:10:18 INFO - 2015-11-02 05:10:18,037 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:10:18 INFO - 2015-11-02 05:10:18,037 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:10:18 INFO - 2015-11-02 05:10:18,037 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,929 05:10:18 INFO - 2015-11-02 05:10:18,037 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:10:18 INFO - 2015-11-02 05:10:18,037 DEBUG : BROWSER_OUTPUT: __startTimestamp1446469818029__endTimestamp 05:10:18 INFO - 2015-11-02 05:10:18,037 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,037 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:10:18 INFO - 2015-11-02 05:10:18,038 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:10:18 INFO - 2015-11-02 05:10:18,038 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,038 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:110.50 stddev:6.81 (6.2%) stddev-sans-first:6.88 05:10:18 INFO - 2015-11-02 05:10:18,038 DEBUG : BROWSER_OUTPUT: Values: 106.0 109.0 105.0 112.0 108.0 109.0 106.0 121.0 122.0 121.0 05:10:18 INFO - 2015-11-02 05:10:18,038 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,039 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:161.50 Median:169.00 stddev:17.30 (10.2%) stddev-sans-first:18.00 05:10:18 INFO - 2015-11-02 05:10:18,039 DEBUG : BROWSER_OUTPUT: Values: 171.0 145.0 175.0 188.0 144.0 167.0 163.0 141.0 179.0 142.0 05:10:18 INFO - 2015-11-02 05:10:18,039 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,039 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:178.80 Median:180.50 stddev:3.26 (1.8%) stddev-sans-first:2.70 05:10:18 INFO - 2015-11-02 05:10:18,039 DEBUG : BROWSER_OUTPUT: Values: 173.0 180.0 181.0 181.0 182.0 178.0 173.0 180.0 179.0 181.0 05:10:18 INFO - 2015-11-02 05:10:18,039 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,040 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.40 Median:91.00 stddev:9.94 (10.9%) stddev-sans-first:9.80 05:10:18 INFO - 2015-11-02 05:10:18,040 DEBUG : BROWSER_OUTPUT: Values: 75.0 90.0 99.0 98.0 79.0 76.0 78.0 92.0 93.0 74.0 05:10:18 INFO - 2015-11-02 05:10:18,040 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,040 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:116.30 Median:105.50 stddev:23.13 (21.9%) stddev-sans-first:24.17 05:10:18 INFO - 2015-11-02 05:10:18,040 DEBUG : BROWSER_OUTPUT: Values: 105.0 106.0 150.0 100.0 100.0 100.0 150.0 103.0 100.0 149.0 05:10:18 INFO - 2015-11-02 05:10:18,040 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,040 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:133.60 Median:135.00 stddev:3.24 (2.4%) stddev-sans-first:2.98 05:10:18 INFO - 2015-11-02 05:10:18,040 DEBUG : BROWSER_OUTPUT: Values: 129.0 137.0 135.0 136.0 129.0 129.0 136.0 135.0 135.0 135.0 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:141.10 Median:141.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: Values: 141.0 141.0 143.0 141.0 140.0 141.0 141.0 141.0 141.0 141.0 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:114.40 Median:114.00 stddev:2.76 (2.4%) stddev-sans-first:2.64 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 118.0 117.0 114.0 113.0 113.0 119.0 114.0 111.0 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.50 stddev:4.28 (6.6%) stddev-sans-first:4.04 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 62.0 64.0 63.0 65.0 64.0 74.0 66.0 68.0 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:74.20 Median:75.50 stddev:2.57 (3.4%) stddev-sans-first:1.92 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 74.0 75.0 76.0 76.0 75.0 76.0 75.0 76.0 05:10:18 INFO - 2015-11-02 05:10:18,041 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,042 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:97.80 Median:97.00 stddev:2.20 (2.3%) stddev-sans-first:1.86 05:10:18 INFO - 2015-11-02 05:10:18,042 DEBUG : BROWSER_OUTPUT: Values: 94.0 97.0 97.0 101.0 101.0 99.0 97.0 97.0 96.0 99.0 05:10:18 INFO - 2015-11-02 05:10:18,042 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,042 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:147.00 stddev:5.46 (3.7%) stddev-sans-first:5.79 05:10:18 INFO - 2015-11-02 05:10:18,042 DEBUG : BROWSER_OUTPUT: Values: 147.0 144.0 156.0 144.0 147.0 147.0 135.0 152.0 145.0 147.0 05:10:18 INFO - 2015-11-02 05:10:18,042 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,042 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.50 Median:167.50 stddev:4.72 (2.8%) stddev-sans-first:4.38 05:10:18 INFO - 2015-11-02 05:10:18,042 DEBUG : BROWSER_OUTPUT: Values: 161.0 171.0 178.0 165.0 166.0 165.0 165.0 170.0 169.0 165.0 05:10:18 INFO - 2015-11-02 05:10:18,042 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,042 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.50 Median:80.00 stddev:3.27 (4.1%) stddev-sans-first:2.49 05:10:18 INFO - 2015-11-02 05:10:18,043 DEBUG : BROWSER_OUTPUT: Values: 73.0 76.0 78.0 80.0 80.0 82.0 83.0 84.0 80.0 79.0 05:10:18 INFO - 2015-11-02 05:10:18,043 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:10:18 INFO - 2015-11-02 05:10:18,043 DEBUG : BROWSER_OUTPUT: 05:10:18 INFO - 2015-11-02 05:10:18,762 INFO : Browser exited with error code: 0 05:10:18 INFO - 2015-11-02 05:10:18,813 INFO : Completed test kraken (00:01:00) 05:10:18 INFO - 2015-11-02 05:10:18,813 INFO : Starting test v8_7 05:10:18 INFO - 2015-11-02 05:10:18,813 DEBUG : operating with platform_type : mac_ 05:10:18 INFO - 2015-11-02 05:10:18,814 INFO : Initialising browser for v8_7 test... 05:10:18 INFO - 2015-11-02 05:10:18,828 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpoPCqTC/profile http://localhost:49271/getInfo.html 05:10:21 INFO - 2015-11-02 05:10:21,157 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:10:21 INFO - 2015-11-02 05:10:21,157 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:10:21 INFO - 2015-11-02 05:10:21,157 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:10:21 INFO - 2015-11-02 05:10:21,157 DEBUG : BROWSER_OUTPUT: __metrics 05:10:21 INFO - 2015-11-02 05:10:21,175 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:10:21 INFO - 2015-11-02 05:10:21,916 INFO : Browser initialized. 05:10:21 INFO - 2015-11-02 05:10:21,917 INFO : Running cycle 1/1 for v8_7 test... 05:10:21 INFO - 2015-11-02 05:10:21,917 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/T/tmpoPCqTC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:10:33 INFO - 2015-11-02 05:10:33,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 220635136 05:10:33 INFO - 2015-11-02 05:10:33,887 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49271/tests/v8_7/run.html (next: http://localhost:49271/tests/v8_7/run.html) 05:10:56 INFO - 2015-11-02 05:10:56,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 684359680 05:10:56 INFO - 2015-11-02 05:10:56,945 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,945 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:10:56 INFO - 2015-11-02 05:10:56,945 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:10:56 INFO - 2015-11-02 05:10:56,945 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:10:56 INFO - 2015-11-02 05:10:56,945 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:10:56 INFO - 2015-11-02 05:10:56,945 DEBUG : BROWSER_OUTPUT: |0;Richards;173.94329448599757 05:10:56 INFO - 2015-11-02 05:10:56,945 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;211.23785382340515 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: |2;Encrypt;356.2522265764161 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6369.426751592357 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2304.147465437788 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: |5;Earley;1004.0160642570281 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: |6;Boyer;13945.205479452055 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: |7;RegExp;32047.619047619046 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: |8;Splay;705.9238363892807 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6448.717948717948 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: __startTimestamp1446469856937__endTimestamp 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,946 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.94 Median:173.94 stddev:0.00 (0.0%) 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: Values: 173.9 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:211.24 Median:211.24 stddev:0.00 (0.0%) 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: Values: 211.2 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:356.25 Median:356.25 stddev:0.00 (0.0%) 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: Values: 356.3 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6369.43 Median:6369.43 stddev:0.00 (0.0%) 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: Values: 6369.4 05:10:56 INFO - 2015-11-02 05:10:56,947 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2304.15 Median:2304.15 stddev:0.00 (0.0%) 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: Values: 2304.1 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1004.02 Median:1004.02 stddev:0.00 (0.0%) 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: Values: 1004.0 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13945.21 Median:13945.21 stddev:0.00 (0.0%) 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: Values: 13945.2 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32047.62 Median:32047.62 stddev:0.00 (0.0%) 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: Values: 32047.6 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,948 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:705.92 Median:705.92 stddev:0.00 (0.0%) 05:10:56 INFO - 2015-11-02 05:10:56,949 DEBUG : BROWSER_OUTPUT: Values: 705.9 05:10:56 INFO - 2015-11-02 05:10:56,949 DEBUG : BROWSER_OUTPUT: 05:10:56 INFO - 2015-11-02 05:10:56,949 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6448.72 Median:6448.72 stddev:0.00 (0.0%) 05:10:56 INFO - 2015-11-02 05:10:56,949 DEBUG : BROWSER_OUTPUT: Values: 6448.7 05:10:56 INFO - 2015-11-02 05:10:56,949 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:10:56 INFO - 2015-11-02 05:10:56,949 DEBUG : BROWSER_OUTPUT: 05:10:57 INFO - 2015-11-02 05:10:57,668 INFO : Browser exited with error code: 0 05:10:57 INFO - 2015-11-02 05:10:57,689 INFO : Completed test v8_7 (00:00:38) 05:10:57 INFO - 2015-11-02 05:10:57,733 INFO : Completed test suite (00:20:14) 05:10:57 INFO - 2015-11-02 05:10:57,733 DEBUG : Working with test: dromaeo_css 05:10:57 INFO - 2015-11-02 05:10:57,733 DEBUG : Generating results file: dromaeo_css 05:10:57 INFO - 2015-11-02 05:10:57,734 DEBUG : Working with test: kraken 05:10:57 INFO - 2015-11-02 05:10:57,734 DEBUG : Generating results file: kraken 05:10:57 INFO - 2015-11-02 05:10:57,735 INFO : javascript benchmark 05:10:57 INFO - 2015-11-02 05:10:57,735 DEBUG : Working with test: v8_7 05:10:57 INFO - 2015-11-02 05:10:57,735 DEBUG : Generating results file: v8_7 05:10:57 INFO - 2015-11-02 05:10:57,735 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:10:57 INFO - 2015-11-02 05:10:57,800 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 05:10:57 INFO - 2015-11-02 05:10:57,800 DEBUG : process_Request line: dromaeo_css 6078.72 graph.html#tests=[[72,64,55]] 05:10:57 INFO - 2015-11-02 05:10:57,800 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:10:57 INFO - 2015-11-02 05:10:57,828 DEBUG : process_Request line: kraken 1672.90 graph.html#tests=[[232,64,55]] 05:10:57 INFO - 2015-11-02 05:10:57,828 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:10:57 INFO - 2015-11-02 05:10:57,857 DEBUG : process_Request line: v8_7 16609.28 graph.html#tests=[[230,64,55]] 05:10:57 INFO - 2015-11-02 05:10:57,858 INFO : javascript benchmark 05:10:57 INFO - 2015-11-02 05:10:57,860 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [299.57310832064303, 308.78076565638395, 314.48738556153467, 314.64759469394284, 314.96377916539603, 12872.09895307329, 13267.800982985264, 15199.544013679593, 15758.68482630348, 15997.60005999849, 10609.469526523662, 10868.0, 10968.561257549689, 13612.93193534031, 15854.365825367, 3987.8604248851225, 4046.1705350403245, 4054.371572406267, 4082.448869402622, 4089.734167279117, 3099.0, 3201.055688571865, 3801.258754542865, 3822.522184726909, 4251.4898212214575, 4328.610425061744, 4330.718503297291, 4362.8909277268, 4373.868783936487, 4386.0, 4238.982644165409, 4298.441202643637, 4299.871003869874, 4322.438083049199, 4361.498427680825, 3682.576503702082, 3688.815559222055, 3711.740178187528, 3715.294094122135, 3736.7384283099923, 11280.717982050432, 11781.705457363549, 11821.290722556674, 12334.444949977273, 12442.564510242099, 1678.5132311629613, 1702.0, 1723.4829551134735, 1791.4177892185091, 1814.4738025972451, 12464.252144871247, 12519.624411267676, 12656.240625562496, 12833.743325133539, 13433.66415839612, 1586.754053121768, 1613.7337339338994, 1622.9350825966947, 1647.666636745364, 1653.84288492593, 58260.0, 61122.694386527786, 61754.38245617531, 61907.38092619061, 62110.37889621091, 15717.764233536505, 15948.76076858848, 15996.280167392495, 16053.0, 16149.677006459806, 22739.545209095726, 22788.886055569616, 22803.771962280498, 22866.199683011015, 22942.65586016211, 8854.468731876108, 9241.168294853496, 9293.117153870371, 9382.790058698638, 9460.24318054554, 7652.502587331805, 8017.118117007125, 8034.276915077671, 8122.472039317426, 8189.918100818915, 7407.962885196077, 7438.776836694908, 7447.627618619155, 7517.8120546985665, 7519.323260906544, 2878.280429892527, 2883.567464880243, 2897.6522817261643, 2941.794074414813, 3017.1853599528445, 363.93085313790294, 367.514880357925, 375.72008853403844, 386.63269893601193, 401.91358857845705, 9872.851907221397, 10101.64644237463, 10197.13324367437, 10303.227257955534, 10386.844197337046, 399.3550416078013, 400.7154920006828, 401.54023642928684, 406.991860162801, 409.7172950664092, 5451.073317536028, 5718.656880587178, 5732.684702341411, 5760.942390576124, 5797.942020579824, 509080.0, 516519.0, 517131.0, 530831.0, 534100.0, 52431.0, 58455.41544584585, 60749.0, 61960.380396196364, 63932.0, 436.32152003634656, 437.08430837395605, 437.2915876280446, 443.46562392317827, 444.0563801920854, 9642.228621710106, 9926.404415735078, 9931.553080111267, 10161.237907156845, 10194.796104077728, 30096.548551771302, 31550.0, 31557.211069723442, 32172.678273217905, 32248.677513224568, 41455.37816932809, 42278.365824513276, 42708.78645606877, 42990.57009429991, 43602.473913412876, 5523.502884740393, 5637.887242255214, 5686.800961966312, 5691.601587888974, 5708.885822283614, 10405.739856503647, 10491.527881245209, 10967.177461690564, 10984.615538456115, 10995.780084398428, 9207.079292070739, 9407.717768466957, 9418.10527999839, 9431.481268530297, 9463.668771592962, 8668.133186681282, 8944.552772361487, 9013.549322533978, 9064.90935090667, 9088.636454541744, 9214.2628589714, 9359.67241146584, 9475.52622368865, 9559.283053770856, 9565.234781217347, 5404.83785486436, 5548.778048878161, 5601.355844077821, 5686.374498805046, 5707.714614269187, 8969.50667713256, 9123.954380228322, 9255.861162082709, 9255.953720231355, 9308.348415610842], "dojo.html": [2888.4800735867534, 2916.256354629569, 2941.4852400829855, 2955.2611847038243, 3015.110542389995, 4610.654200934927, 4656.441227052755, 4720.669553131283, 4812.542808433198, 4897.31437598736, 4700.882477938053, 4702.177119004169, 4702.90594188116, 4849.878753031176, 4892.3884514435695, 4412.139632771611, 4417.734935903856, 4420.845270415536, 4434.357018232355, 4518.751468669222, 4487.19230538503, 4500.684952053358, 4538.115067561826, 4593.448786145667, 4600.401947746805, 4296.8281268749215, 4355.869323920288, 4403.0, 4477.3731677565165, 4507.729536227836, 4371.431713877208, 4433.9113217735785, 4475.172093162742, 4485.125400546862, 4546.272596384596, 4410.140022695576, 4446.444194475691, 4453.977730111329, 4462.018355961715, 4485.035717320791, 4683.7892294846815, 4714.481407045222, 4754.239321708545, 4775.689580177277, 4807.254875494304, 5070.492950704936, 5077.593792496591, 5089.033083714119, 5138.6916784992645, 5172.069027575035, 5146.356705411824, 5166.405863325691, 5168.664036837594, 5200.323957885451, 5278.5249327560705, 4684.039771846763, 4752.857414277542, 4766.6901651392545, 4774.4509381420885, 4798.136335459616, 5230.084735171406, 5279.234510995961, 5287.762050707727, 5328.866778330495, 5376.73116344189, 5057.949420505822, 5071.873203169876, 5077.771500282496, 5107.565856902131, 5186.688798672017, 4983.9252411213865, 5058.140116180258, 5150.587952963754, 5168.457311982188, 5220.738963051908, 5066.265391518283, 5127.46161653021, 5159.664621799571, 5182.352205974254, 5195.272661827347, 5114.948850511521, 5125.359330083739, 5177.197534382177, 5185.714785686823, 5191.143461328914, 3863.9806800965816, 3999.7800120993043, 4026.154507553388, 4062.614051665087, 4067.7966101694797, 3680.4111342185656, 3693.4275187346007, 3699.667029967316, 3742.326381251401, 3749.3251214781603, 4827.396575428072, 4846.36997190363, 4850.393700787402, 4878.585320247747, 4909.901801963941, 5053.772580233825, 5164.25118357836, 5172.741362931838, 5234.555062819703, 5286.682799031993, 4843.273508973612, 4884.975575122173, 4885.462599114095, 4893.02139572087, 4904.8773780655765, 4609.9308510372375, 4612.031473390625, 4625.398698169217, 4655.4180727409075, 4661.813527458864, 5098.337216161875, 5179.2749015137915, 5252.579793616502, 5266.605004624746, 5327.0, 5209.713465759268, 5213.530782229617, 5217.2434996925995, 5227.529522343008, 5277.313949186581, 5258.526732594085, 5276.472352764847, 5301.072859880953, 5323.787048518016, 5369.328833895763, 4937.728424936663, 4942.703437793743, 5029.823956161516, 5125.077486052546, 5204.141316682705, 5217.556507696737, 5225.973870130625, 5226.45122262157, 5252.947470525246, 5270.947290527046, 5050.49495050492, 5100.846974590768, 5107.565856902205, 5111.437741848319, 5138.434772174983, 5016.347874776256, 5043.9747801260755, 5098.668586541863, 5105.795768169231, 5176.637635365489, 4886.560209581155, 4997.550220480174, 5010.674306170087, 5064.848054558369, 5066.4680208577565, 5106.029854327666, 5132.178851383761, 5170.1986192140275, 5199.454057324077, 5208.5051920067535, 4786.210275304675, 4832.95167048325, 4902.068606964665, 4905.460399355997, 4978.502149784992], "mootools.html": [779.9649015794296, 1291.6383412644464, 1514.4472267622314, 1525.710115078135, 1639.377036726044, 6281.937180628192, 6510.902336464951, 7085.751998680047, 7087.610181440019, 7183.353498185163, 6885.277045910182, 7038.331358520945, 7043.225245223021, 7096.183938847034, 7108.0759501264765, 1772.2290803500518, 1805.873588848781, 1971.1721077147597, 1976.6145601607693, 2003.108616665577, 2025.3518873960338, 2082.9895850520725, 2087.5720477302116, 2099.7060411542398, 2102.905369258387, 1967.0, 2000.2299114840746, 2006.5585571174317, 2024.564718585504, 2031.8069783370556, 1960.255103060842, 1987.3044434447972, 2015.4659015360867, 2019.8889061101634, 2035.765886923008, 2008.0361426515356, 2008.979910200894, 2009.768876579183, 2035.562354093862, 2038.816506514406, 6921.065656136458, 7017.47368947331, 7021.89467157993, 7085.82285442868, 7114.715411383539, 4216.7259128156575, 4310.52584215736, 4317.589828966243, 4341.0, 4382.846600368972, 2513.0952856971476, 2529.8861551230057, 2594.7664710175986, 2611.2688447234805, 2626.2383908666466, 692.3595674001529, 713.6717110129347, 773.6750564762813, 789.9486533375369, 822.0587427395658, 9130.863037054449, 9195.264378849675, 9242.260619150518, 9242.399244049115, 9259.722208333827, 3952.288588054178, 4027.7583344999393, 4049.311617025113, 4050.736702114353, 4080.81636326366, 8152.328772601602, 8218.876716849252, 8224.054233763074, 8233.217844304781, 8248.8350232995, 4341.717788343811, 4433.955660443355, 4486.282194848808, 4491.3487544306545, 4495.25828238337, 4054.108096218827, 4059.4316795648633, 4061.7156799024374, 4104.835806567764, 4105.261053010427, 3315.4251730427854, 3375.2236985493473, 3425.6403077676487, 3460.3425349183576, 3471.5139880416764, 1062.3148069495132, 1084.5065495199665, 1105.789899919013, 1106.397013627575, 1107.241539545414, 901.4185850126631, 922.4419226368085, 922.7231830450838, 1024.288119756762, 1081.0378762901025, 6690.19717633887, 6720.831979200461, 6732.562383445061, 6750.864982700318, 6778.288279730656, 419.4421419512042, 423.9894002649897, 424.2999051564881, 424.73454091193, 425.9936100958488, 5167.948320516747, 5343.5190832824455, 5353.330833645794, 5405.054115529767, 5412.621116521885, 7490.588017659081, 8034.397420193509, 8188.2630563249595, 8284.08875023747, 8297.128801475757, 7298.96350518244, 8197.46716463428, 8201.630926608317, 8314.334853211729, 8339.45793523419, 6421.197350331208, 6553.180852393451, 6592.472602191813, 6619.966900165468, 6623.039659249382, 6445.2265728112925, 6623.0, 6702.899456508254, 6712.295209002984, 6726.495512836655, 7292.124945006421, 7400.592967386845, 7520.699172033057, 7584.5070070445245, 7623.733169339046, 7345.118585769528, 7570.786907214024, 7654.885176722242, 7675.53946763196, 7742.722450795555, 6189.659568723763, 6231.096491008869, 6234.781782637586, 6298.874022519615, 6314.052892066226, 6592.80221593353, 6751.223609284799, 6772.322767723188, 6798.218204906499, 6888.138982627172, 6296.412822548727, 6354.3963323484195, 6370.0, 6460.192475940507, 6508.056331831953, 6288.308286088618, 6291.528135389955, 6297.622142671455, 6323.304436512072, 6409.839754006187, 6426.775062872777, 6440.710168042356, 6459.61242325462, 6489.221293444817, 6570.934290657224, 5894.0, 5902.409759024235, 5921.970390148022, 5945.286565612154, 5965.582409231312, 5976.432238937294, 5988.910166347421, 6023.186869772525, 6029.457348838626, 6040.0], "ext.html": [501.8569707633324, 506.1648280337443, 508.2427183496589, 520.7084032941552, 528.2050513976469, 28051.719482805165, 28846.423071538557, 35697.2860542789, 36740.81629591855, 36769.0, 38239.23521529568, 39158.80420597893, 39255.80372098143, 39733.40399894004, 39762.0, 7416.925830741678, 8453.027901791296, 8528.914710852874, 8547.615357308905, 8571.14288571141, 7555.282248186413, 9974.202063834911, 10170.288079834414, 10291.897081029168, 10341.948290258539, 9954.800903981915, 10075.596976120947, 10167.186625069977, 10179.134773544258, 10254.794904101913, 7573.394128469764, 7761.573113478757, 10009.69970900874, 10075.395476271411, 10145.49272536374, 9986.600535978552, 10005.0, 10048.296619236584, 10124.69625911224, 10132.0, 35943.0, 36427.4535881962, 36610.0, 36811.0, 36941.07647308812, 2691.286808995618, 2719.986400067987, 2735.1006240133056, 2747.175847245818, 2833.2350265428427, 25149.748502514925, 25321.100917431268, 25349.23952281416, 25674.0, 26253.21240362792, 2140.176032227588, 2154.53677459347, 2156.4608847788054, 2160.34109596573, 2305.8155347572156, 240662.0, 241273.0, 241672.0, 241926.0, 242428.0, 50929.74535127375, 51632.483675163516, 55702.16446753302, 56276.0, 56376.43623563794, 57782.0, 58777.4122258772, 59307.703461482415, 59432.10851837226, 59588.70205648944, 14871.851281487046, 15057.096574205583, 15071.623209419853, 15099.773503397459, 15258.923705381401, 11547.076233901267, 11619.07047436203, 11619.88380116205, 11631.709207269716, 11634.360110193851, 16912.57718557046, 17683.11584420774, 18293.359732409303, 18296.17667204979, 18309.3591724289, 7079.185893622196, 7305.817354566072, 7311.305425984523, 7362.8527429451115, 7364.275218169311, 829.1666874790917, 829.9377546684022, 888.1873086126122, 981.8036392721484, 992.3301771304341, 25716.614250786253, 25974.74025259761, 26230.73769262321, 26284.0, 27281.181564553095, 888.3825741109866, 912.6395073945754, 940.8071345374182, 961.927855410847, 983.9409635421897, 13072.869271307356, 13264.668383290495, 13390.062695611214, 13483.325833708275, 13544.796828047587, 303361.0, 309165.0, 310239.0, 311635.0, 314523.0, 49237.753811230716, 49443.0, 49585.75207123941, 49644.0, 49701.0, 1241.5716577780652, 1248.9437975291135, 1260.294235228275, 1277.201748906933, 1281.0136195129699, 22547.88726056359, 25038.62442063407, 25285.494290114464, 25663.486730265664, 25802.225933222035, 42292.577074228866, 42690.78654606707, 42704.0, 42782.14435711206, 42815.0, 181384.0, 184207.0, 184213.07893460448, 185503.0, 249848.0, 24172.0, 28078.2980425491, 28783.856080719463, 28904.566431503124, 28986.13041608755, 34758.82620586881, 35241.471377928836, 35556.82221588876, 36162.8191859039, 39668.603313966494, 31231.531527027568, 32150.190671751283, 32310.0, 32496.187595310308, 32887.0, 29691.703082968892, 29864.85067574735, 30059.549106762977, 30156.54765178568, 30201.848990754905, 32373.19067023249, 32810.67189328076, 33239.83380083084, 33540.49689254614, 33655.32689346249, 26116.477670446864, 28364.716352837033, 28373.43253134967, 28633.713662863105, 28701.56947645745, 21591.892040539697, 21737.782622173574, 21823.23618673339, 21829.126834926425, 21858.562828743656], "prototype.html": [287.9064304101167, 297.2138693156601, 298.1740578597286, 302.9212404774759, 303.9559263906732, 5354.437784032674, 5489.560835133179, 5512.366077901042, 5530.889382212354, 5565.9443405565935, 5451.127819548873, 5481.862953426166, 5482.451754824516, 5491.807786727465, 5497.47773961473, 4227.556106608808, 4239.512456067546, 4244.872653820375, 4295.720778149418, 4296.0, 4248.2140803951215, 4249.638780703628, 4254.4469219001485, 4257.574242575749, 4260.595243451867, 3980.094671683457, 4036.2331157080207, 4205.03284244624, 4208.158368326332, 4279.358096285567, 4214.536400995873, 4231.978840105795, 4232.195882782262, 4249.6387807036435, 4262.147570485915, 3654.488371627948, 3661.505696730934, 3663.1757854482794, 3678.4114541673202, 3690.280395322913, 5178.896422071575, 5229.477052294778, 5267.183586544092, 5303.337082864642, 5382.381026182, 4705.458872229703, 4705.811767529295, 4723.220668589679, 4743.691660042086, 4745.264484004984, 5723.08430651098, 5735.713214339266, 5757.740901659394, 5761.164631128463, 5765.654060756368, 3937.8621748238675, 3976.224636195943, 3987.943195053313, 3992.061865461614, 4015.578364271768, 5768.625039372428, 5906.82279531619, 6076.939230607726, 6080.787172448987, 6100.847478813021, 3900.395438707005, 3965.306071437487, 3965.325894597925, 3984.8007599619905, 4036.0515278909434, 3999.140184860269, 4091.3862920562156, 4127.2570937230985, 4133.1940271647345, 4139.834406623701, 4718.88202794926, 4728.787204575802, 4758.5241475852135, 4762.571368576845, 4791.5687588117235, 5592.888142237214, 5747.511461525817, 5748.425157484302, 5752.25220721312, 5798.855028624318, 1486.4500134950138, 1488.3971991343524, 1497.311236831048, 1507.1861194954602, 1507.7711664993215, 974.4737841565617, 976.3409698453515, 978.554757585297, 1001.3891526169031, 1001.4391940513336, 5472.72636368188, 5483.862903427446, 5483.862903427446, 5501.944980550224, 5507.9449205507435, 5932.377100404396, 5976.551758618034, 6010.008348622516, 6014.909776353358, 6034.456898879034, 5475.972620136874, 5478.123500239943, 5484.643498172606, 5488.56091512678, 5490.423505531941, 3220.5169224616493, 3305.3554556861664, 3316.751243656687, 3328.184594774296, 3339.699427051577, 6095.756169753249, 6105.114758360101, 6107.267127944675, 6107.480864126599, 6119.0, 6157.138000679908, 6167.444929956326, 6171.105189747462, 6180.289266734293, 6189.0, 5861.736221870026, 6056.727447264883, 6068.089786531968, 6086.756529738761, 6101.115338275925, 6002.219711437485, 6005.939940600713, 6011.489023433057, 6019.819405417845, 6032.638041717511, 5868.970655146697, 5880.470757631833, 5911.940880591139, 5912.231409916683, 5913.793017244376, 5733.913991290051, 6061.121137435135, 6075.696215189311, 6090.695465226632, 6102.115193297036, 3818.560865500392, 3904.2386734586485, 3945.763254204757, 3947.4276229947072, 3949.1311911379453, 5808.30300363959, 5810.564207684356, 5855.443732845373, 6001.639901605918, 6025.276966764016, 5803.65178089316, 5853.385394533683, 5853.882922341614, 5856.0, 5873.794417195549, 5700.515456186271, 5816.592838501433, 5819.854503637443, 5851.473367396955, 5860.736266867916, 5650.35020972577, 5682.488576028178, 5689.573282003784, 5690.118031705092, 5690.800821971211, 5800.9848276552275, 5806.2451881255165, 5813.6221145625395, 5832.445917637818, 5837.241158649348, 5606.467385598362, 5698.173764803997, 5704.629199102211, 5712.400197979152, 5731.910936921971], "yui.html": [621.1831441654224, 683.9076724642175, 689.2452764223174, 696.1228851646927, 698.5963571772342, 11714.062874970003, 11965.581204657828, 12014.399280035996, 12016.49793775778, 12077.698057548565, 11695.473703683334, 12100.757984840298, 12159.756804863897, 12180.634580962564, 12190.451429685663, 631.4664108828033, 640.8846407646622, 651.1632552170462, 803.0804728585766, 829.6473998550622, 817.8691409374501, 820.831729495452, 826.0417915218347, 829.0590180145518, 835.3442547600135, 836.4186890111375, 859.7162936231028, 859.9054104048549, 862.4092496639822, 865.7575878753928, 654.6170490263202, 667.3626686514367, 807.116207752516, 855.153398135841, 857.3569822633025, 631.8420394901275, 633.1926793338484, 633.2590868683651, 634.9777757778455, 642.1812189458432, 12178.81731774024, 12193.45129469176, 12215.572454964122, 12258.019358451302, 12313.815292770616, 10074.345167564084, 10120.240981926385, 10416.42709650969, 10637.46812659364, 10842.945785271102, 8131.471454355507, 8175.059868115124, 8296.004122730508, 8334.913616719728, 8545.2309292164, 2954.497735384968, 3010.9698903011126, 3017.0647099399257, 3080.0, 3082.6317956553257, 43002.1399572013, 43031.56968430338, 43143.35284970728, 43306.0, 43335.78332108351, 6082.817515474543, 6603.669816509156, 8097.109317975018, 8137.552434616153, 8359.247667709935, 10835.458227088615, 10902.5093870776, 10903.563857445772, 10916.01755841978, 10918.181136414642, 5375.247465354853, 5519.834404967857, 5558.416366281563, 5574.749136288796, 5770.826875193751, 2910.9854450728035, 3149.543316219181, 3246.204679853451, 3308.338332333543, 3389.74576906733, 2488.639147323628, 2495.6506089147533, 2508.184839927031, 2516.3709072731817, 2523.0916869926814, 379.4194881830803, 391.6181722820227, 415.9812808423628, 433.83731100837184, 436.68776824570585, 425.7488082031616, 516.5015759791819, 539.7328322480397, 546.4344403542315, 557.4871118570925, 6877.9656101720175, 6910.997905303703, 7293.088363954505, 7314.634268286564, 7344.926550734531, 427.79465856389106, 439.05164843936944, 455.5057762327845, 498.7830293822199, 550.9531689806412, 3297.291082417292, 3343.7993720376367, 3390.6100798408006, 3392.5928888533535, 3432.811195384228, 52495.212571811455, 52778.472215278125, 52863.73568132212, 52923.206151907754, 52935.73532132392, 47052.7647361761, 47480.0, 47694.761526192146, 48024.0, 48577.27134092992, 41541.0, 42437.36343954843, 42617.78691106525, 42977.57022429798, 43565.34651980159, 6757.797266082025, 6951.9652401739695, 7031.296870312928, 7064.222935476991, 7176.820579485555, 32077.67922320747, 32364.83817580897, 33226.0, 33360.332793343514, 33389.33221335511, 43298.35052474152, 43329.56670433381, 44078.55921440745, 44414.77792611016, 44419.0, 5774.884502310014, 6037.818865434044, 6190.7214175363115, 6193.318734939243, 6295.18162638854, 9157.450552966844, 9177.77055573616, 9196.540172991457, 9305.255579553756, 9311.301652376234, 8595.31237501011, 8596.140385961604, 8669.30645548342, 8805.911940880509, 9299.488528131018, 8388.538471829354, 8622.26710729595, 8690.348223883107, 8800.295976321751, 8820.5589720515, 8238.176182381714, 8250.127178239065, 8362.289205417364, 8590.82818343642, 8727.170918762708, 7177.210506844347, 7299.671514781741, 7313.926860731324, 7684.423668224794, 7946.443748937519, 7271.963640181765, 7341.926580734338, 7481.177070522347, 7630.618469076635, 7644.197359277196]}, "summary": {"suite": 6078.722555180115, "subtests": {"jquery.html": {"filtered": 7060.766180316504, "value": 7060.766180316504}, "dojo.html": {"filtered": 4786.09932829493, "value": 4786.09932829493}, "mootools.html": {"filtered": 3925.928225899902, "value": 3925.928225899902}, "ext.html": {"filtered": 16754.21672303175, "value": 16754.21672303175}, "prototype.html": {"filtered": 4354.104583308871, "value": 4354.104583308871}, "yui.html": {"filtered": 5212.329699224396, "value": 5212.329699224396}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1446468643, "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": "45.0a1", "id": "20151102030710", "branch": "Fx-Team", "revision": "cbb27a88e499604c4bf0be54eb5373a001f8cf62"}}, {"talos_counters": {}, "results": {"audio-dft": [173.0, 180.0, 181.0, 181.0, 182.0, 178.0, 173.0, 180.0, 179.0, 181.0], "ai-astar": [106.0, 109.0, 105.0, 112.0, 108.0, 109.0, 106.0, 121.0, 122.0, 121.0], "imaging-gaussian-blur": [129.0, 137.0, 135.0, 136.0, 129.0, 129.0, 136.0, 135.0, 135.0, 135.0], "audio-beat-detection": [171.0, 145.0, 175.0, 188.0, 144.0, 167.0, 163.0, 141.0, 179.0, 142.0], "json-stringify-tinderbox": [69.0, 70.0, 74.0, 75.0, 76.0, 76.0, 75.0, 76.0, 75.0, 76.0], "stanford-crypto-pbkdf2": [161.0, 171.0, 178.0, 165.0, 166.0, 165.0, 165.0, 170.0, 169.0, 165.0], "json-parse-financial": [59.0, 60.0, 62.0, 64.0, 63.0, 65.0, 64.0, 74.0, 66.0, 68.0], "stanford-crypto-sha256-iterative": [73.0, 76.0, 78.0, 80.0, 80.0, 82.0, 83.0, 84.0, 80.0, 79.0], "audio-fft": [75.0, 90.0, 99.0, 98.0, 79.0, 76.0, 78.0, 92.0, 93.0, 74.0], "imaging-darkroom": [141.0, 141.0, 143.0, 141.0, 140.0, 141.0, 141.0, 141.0, 141.0, 141.0], "stanford-crypto-ccm": [147.0, 144.0, 156.0, 144.0, 147.0, 147.0, 135.0, 152.0, 145.0, 147.0], "audio-oscillator": [105.0, 106.0, 150.0, 100.0, 100.0, 100.0, 150.0, 103.0, 100.0, 149.0], "stanford-crypto-aes": [94.0, 97.0, 97.0, 101.0, 101.0, 99.0, 97.0, 97.0, 96.0, 99.0], "imaging-desaturate": [111.0, 114.0, 118.0, 117.0, 114.0, 113.0, 113.0, 119.0, 114.0, 111.0]}, "summary": {"suite": 1672.9, "subtests": {"audio-fft": {"filtered": 85.4, "value": 85.4}, "stanford-crypto-pbkdf2": {"filtered": 167.5, "value": 167.5}, "audio-beat-detection": {"filtered": 161.5, "value": 161.5}, "stanford-crypto-ccm": {"filtered": 146.4, "value": 146.4}, "imaging-darkroom": {"filtered": 141.1, "value": 141.1}, "json-parse-financial": {"filtered": 64.5, "value": 64.5}, "audio-oscillator": {"filtered": 116.3, "value": 116.3}, "ai-astar": {"filtered": 111.9, "value": 111.9}, "audio-dft": {"filtered": 178.8, "value": 178.8}, "stanford-crypto-sha256-iterative": {"filtered": 79.5, "value": 79.5}, "json-stringify-tinderbox": {"filtered": 74.2, "value": 74.2}, "imaging-gaussian-blur": {"filtered": 133.6, "value": 133.6}, "stanford-crypto-aes": {"filtered": 97.8, "value": 97.8}, "imaging-desaturate": {"filtered": 114.4, "value": 114.4}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1446468643, "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": "45.0a1", "id": "20151102030710", "branch": "Fx-Team", "revision": "cbb27a88e499604c4bf0be54eb5373a001f8cf62"}}, {"talos_counters": {}, "results": {"DeltaBlue": [211.23785382340515], "Encrypt": [356.2522265764161], "NavierStokes": [6448.717948717948], "Decrypt": [6369.426751592357], "Splay": [705.9238363892807], "Richards": [173.94329448599757], "RegExp": [32047.619047619046], "Earley": [1004.0160642570281], "Boyer": [13945.205479452055], "RayTrace": [2304.147465437788]}, "summary": {"suite": 16609.281057497647, "subtests": {"DeltaBlue": {"filtered": 313.002612, "value": 313.002612}, "Encrypt": {"filtered": 747.1700669999999, "value": 747.1700669999999}, "NavierStokes": {"filtered": 230.12326043737562, "value": 230.12326043737562}, "Decrypt": {"filtered": 41.79041699999997, "value": 41.79041699999997}, "Splay": {"filtered": 115.4387992007992, "value": 115.4387992007992}, "RegExp": {"filtered": 28.4259806835067, "value": 28.4259806835067}, "Richards": {"filtered": 202.95119799999992, "value": 202.95119799999992}, "Earley": {"filtered": 663.7971480000001, "value": 663.7971480000001}, "Boyer": {"filtered": 47.791551080550065, "value": 47.791551080550065}, "RayTrace": {"filtered": 321.15522599999986, "value": 321.15522599999986}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0013"}, "testrun": {"date": 1446468643, "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": "45.0a1", "id": "20151102030710", "branch": "Fx-Team", "revision": "cbb27a88e499604c4bf0be54eb5373a001f8cf62"}}] 05:10:57 INFO - RETURN: dromaeo_css: 6078.72 05:10:57 INFO - RETURN: kraken: 1672.90 05:10:57 INFO - RETURN: v8_7: 16609.28 05:10:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "16609.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1672.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6078.72"}}} 05:10:57 INFO - Return code: 0 05:10:57 INFO - # TBPL SUCCESS # 05:10:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:58 INFO - 2015-11-02 05:10:57.998 screenresolution[1652:9879] starting screenresolution argv=screenresolution get 05:10:58 INFO - 2015-11-02 05:10:58.003 screenresolution[1652:9879] Display 0: 1600x1200x32@60 05:10:58 INFO - 2015-11-02 05:10:58.010 screenresolution[1653:9882] starting screenresolution argv=screenresolution list 05:10:58 INFO - Available Modes on Display 0 05:10:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:58 INFO - Intel HD Graphics 3000: 05:10:58 INFO - Chipset Model: Intel HD Graphics 3000 05:10:58 INFO - Type: GPU 05:10:58 INFO - Bus: Built-In 05:10:58 INFO - VRAM (Total): 512 MB 05:10:58 INFO - VRAM (Dynamic, Max): 10 05:10:58 INFO - Vendor: Intel (0x8086) 05:10:58 INFO - Device ID: 0x0116 05:10:58 INFO - Revision ID: 0x0009 05:10:58 INFO - Displays: 05:10:58 INFO - Display: 05:10:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:58 INFO - Display Serial Number: 1600x1200 60 05:10:58 INFO - Main Display: Yes 05:10:58 INFO - Mirror: Off 05:10:58 INFO - Online: Yes 05:10:58 INFO - Rotation: Supported 05:10:58 INFO - Return code: 0 05:10:58 INFO - Running post-action listener: _resource_record_post_action 05:10:58 INFO - Running post-run listener: _resource_record_post_run 05:10:59 INFO - Total resource usage - Wall time: 1255s; CPU: 30.0%; Read bytes: 40928256; Write bytes: 687740928; Read time: 4813; Write time: 49346 05:10:59 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 334293504; Write bytes: 337457152; Read time: 34367; Write time: 6592 05:10:59 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 39990272; Write bytes: 339863552; Read time: 4310; Write time: 40542 05:10:59 INFO - Running post-run listener: _upload_blobber_files 05:10:59 INFO - Blob upload gear active. 05:10:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:10:59 INFO - Copying logs to upload dir... 05:10:59 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1310.979416 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2015-11-02 05:10:59.431557) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 05:10:59.435261) ========= 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.kT1FYdZPae/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.fwZiDRp86a/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010083 build_url: 'https://queue.taskcluster.net/v1/task/_iKCiw9IRwisgqpKDCqyOQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-02 05:10:59.467352) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 05:10:59.467937) ========= 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.kT1FYdZPae/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.fwZiDRp86a/Listeners TMPDIR=/var/folders/y_/n7pn5g214xl8tk4w77mb5kh000000w/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.005200 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-02 05:10:59.519776) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 05:10:59.520286) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-02 05:10:59.520944) ========= ========= Total master_lag: 0.45 =========