builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0062 starttime: 1447955287.29 results: success (0) buildid: 20151119071604 builduid: d72044f35f6e4d5abbfbbc85be708d73 revision: 967b96aa1ae114c1c2c63f73ab80c4d5b79419bf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.289699) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.290200) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.290568) ========= 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.v4I2osg3Rk/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.sKEY6ob42C/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005853 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.311819) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.312135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.327207) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.327528) ========= 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.v4I2osg3Rk/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.sKEY6ob42C/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005322 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.379454) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.379822) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.380240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.380578) ========= 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.v4I2osg3Rk/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.sKEY6ob42C/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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:0:0 using PTY: False --2015-11-19 09:48: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.41G=0s 2015-11-19 09:48:07 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153520 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.548113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.548497) ========= 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.v4I2osg3Rk/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.sKEY6ob42C/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.018926 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:07.597045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-19 09:48:07.597442) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 967b96aa1ae114c1c2c63f73ab80c4d5b79419bf --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 967b96aa1ae114c1c2c63f73ab80c4d5b79419bf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.v4I2osg3Rk/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.sKEY6ob42C/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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:0:0 using PTY: False 2015-11-19 09:48:07,670 truncating revision to first 12 chars 2015-11-19 09:48:07,671 Setting DEBUG logging. 2015-11-19 09:48:07,671 attempt 1/10 2015-11-19 09:48:07,671 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/967b96aa1ae1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 09:48:09,841 unpacking tar archive at: fx-team-967b96aa1ae1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.410202 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-19 09:48:10.022762) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:10.023146) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:10.035729) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:10.036141) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 09:48:10.036745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-19 09:48:10.037118) ========= /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.v4I2osg3Rk/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.sKEY6ob42C/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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:0:0 using PTY: False 09:48:10 INFO - MultiFileLogger online at 20151119 09:48:10 in /builds/slave/test 09:48:10 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 09:48:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:10 INFO - {'append_to_log': False, 09:48:10 INFO - 'base_work_dir': '/builds/slave/test', 09:48:10 INFO - 'blob_upload_branch': 'Fx-Team', 09:48:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:10 INFO - 'branch': 'Fx-Team', 09:48:10 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:10 INFO - 'config_files': ('talos/mac_config.py',), 09:48:10 INFO - 'default_actions': ('clobber', 09:48:10 INFO - 'read-buildbot-config', 09:48:10 INFO - 'download-and-extract', 09:48:10 INFO - 'populate-webroot', 09:48:10 INFO - 'create-virtualenv', 09:48:10 INFO - 'install', 09:48:10 INFO - 'run-tests'), 09:48:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:10 INFO - 'download_minidump_stackwalk': True, 09:48:10 INFO - 'download_symbols': 'ondemand', 09:48:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:10 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:10 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:10 INFO - 'installer_path': 'installer.exe', 09:48:10 INFO - 'log_level': 'info', 09:48:10 INFO - 'log_name': 'talos', 09:48:10 INFO - 'log_to_console': True, 09:48:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:48:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:48:10 INFO - 'opt_config_files': (), 09:48:10 INFO - 'pip_index': False, 09:48:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:10 INFO - 'cmd': ('bash', 09:48:10 INFO - '-c', 09:48:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:10 INFO - 'enabled': True, 09:48:10 INFO - 'halt_on_failure': False, 09:48:10 INFO - 'name': 'check_screen_resolution'},), 09:48:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:48:10 INFO - 'cmd': ('bash', 09:48:10 INFO - '-c', 09:48:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:48:10 INFO - 'enabled': True, 09:48:10 INFO - 'halt_on_failure': False, 09:48:10 INFO - 'name': 'check_screen_resolution'},), 09:48:10 INFO - 'run_cmd_checks_enabled': True, 09:48:10 INFO - 'sps_profile': False, 09:48:10 INFO - 'sps_profile_interval': 0, 09:48:10 INFO - 'suite': 'dromaeojs', 09:48:10 INFO - 'system_bits': '64', 09:48:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:10 INFO - 'title': 't-yosemite-r7-0062', 09:48:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:10 INFO - 'use_talos_json': True, 09:48:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:10 INFO - 'work_dir': 'build'} 09:48:10 INFO - ##### 09:48:10 INFO - ##### Running clobber step. 09:48:10 INFO - ##### 09:48:10 INFO - Running pre-action listener: _resource_record_pre_action 09:48:10 INFO - Running main action method: clobber 09:48:10 INFO - rmtree: /builds/slave/test/build 09:48:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:11 INFO - Running post-action listener: _resource_record_post_action 09:48:11 INFO - ##### 09:48:11 INFO - ##### Running read-buildbot-config step. 09:48:11 INFO - ##### 09:48:11 INFO - Running pre-action listener: _resource_record_pre_action 09:48:11 INFO - Running main action method: read_buildbot_config 09:48:11 INFO - Using buildbot properties: 09:48:11 INFO - { 09:48:11 INFO - "properties": { 09:48:11 INFO - "buildnumber": 2, 09:48:11 INFO - "product": "firefox", 09:48:11 INFO - "script_repo_revision": "production", 09:48:11 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:48:11 INFO - "repository": "", 09:48:11 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:48:11 INFO - "buildid": "20151119071604", 09:48:11 INFO - "slavename": "t-yosemite-r7-0062", 09:48:11 INFO - "pgo_build": "False", 09:48:11 INFO - "basedir": "/builds/slave/test", 09:48:11 INFO - "project": "", 09:48:11 INFO - "platform": "yosemite_r7", 09:48:11 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:48:11 INFO - "slavebuilddir": "test", 09:48:11 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:48:11 INFO - "branch": "fx-team", 09:48:11 INFO - "repo_path": "integration/fx-team", 09:48:11 INFO - "stage_platform": "macosx64", 09:48:11 INFO - "builduid": "d72044f35f6e4d5abbfbbc85be708d73", 09:48:11 INFO - "revision": "967b96aa1ae114c1c2c63f73ab80c4d5b79419bf" 09:48:11 INFO - }, 09:48:11 INFO - "sourcestamp": { 09:48:11 INFO - "repository": "", 09:48:11 INFO - "hasPatch": false, 09:48:11 INFO - "project": "", 09:48:11 INFO - "branch": "fx-team-macosx64-talos", 09:48:11 INFO - "changes": [ 09:48:11 INFO - { 09:48:11 INFO - "category": null, 09:48:11 INFO - "files": [ 09:48:11 INFO - { 09:48:11 INFO - "url": null, 09:48:11 INFO - "name": "https://queue.taskcluster.net/v1/task/5FLFna8fTjOGzsOACVEM0A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 09:48:11 INFO - } 09:48:11 INFO - ], 09:48:11 INFO - "repository": "", 09:48:11 INFO - "rev": "484c6f441151b3404f24c855dea1157558b0b9e6", 09:48:11 INFO - "who": "cbook@mozilla.com", 09:48:11 INFO - "when": 1447948940, 09:48:11 INFO - "number": 6683299, 09:48:11 INFO - "comments": "Merge mozilla-central to fx-team", 09:48:11 INFO - "project": "", 09:48:11 INFO - "at": "Thu 19 Nov 2015 08:02:20", 09:48:11 INFO - "branch": "fx-team-macosx64-talos", 09:48:11 INFO - "revlink": "", 09:48:11 INFO - "properties": [ 09:48:11 INFO - [ 09:48:11 INFO - "buildid", 09:48:11 INFO - "20151119062508", 09:48:11 INFO - "Change" 09:48:11 INFO - ], 09:48:11 INFO - [ 09:48:11 INFO - "builduid", 09:48:11 INFO - "c1ca4347bd8b48a0b4d36bbfbdc8a868", 09:48:11 INFO - "Change" 09:48:11 INFO - ], 09:48:11 INFO - [ 09:48:11 INFO - "pgo_build", 09:48:11 INFO - "False", 09:48:11 INFO - "Change" 09:48:11 INFO - ] 09:48:11 INFO - ], 09:48:11 INFO - "revision": "484c6f441151b3404f24c855dea1157558b0b9e6" 09:48:11 INFO - }, 09:48:11 INFO - { 09:48:11 INFO - "category": null, 09:48:11 INFO - "files": [ 09:48:11 INFO - { 09:48:11 INFO - "url": null, 09:48:11 INFO - "name": "https://queue.taskcluster.net/v1/task/Wn7sZ1XYSQ2_I7WSn4fIZw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 09:48:11 INFO - } 09:48:11 INFO - ], 09:48:11 INFO - "repository": "", 09:48:11 INFO - "rev": "83112749ad274d0db90432f26f042d9df30eed91", 09:48:11 INFO - "who": "alessio.placitelli@gmail.com", 09:48:11 INFO - "when": 1447949791, 09:48:11 INFO - "number": 6683400, 09:48:11 INFO - "comments": "Bug 1222054 - Fix broken tests. r=gfritzsche", 09:48:11 INFO - "project": "", 09:48:11 INFO - "at": "Thu 19 Nov 2015 08:16:31", 09:48:11 INFO - "branch": "fx-team-macosx64-talos", 09:48:11 INFO - "revlink": "", 09:48:11 INFO - "properties": [ 09:48:11 INFO - [ 09:48:11 INFO - "buildid", 09:48:11 INFO - "20151119063406", 09:48:11 INFO - "Change" 09:48:11 INFO - ], 09:48:11 INFO - [ 09:48:11 INFO - "builduid", 09:48:11 INFO - "4760ae93ee48423499a72fc30d052ac8", 09:48:11 INFO - "Change" 09:48:11 INFO - ], 09:48:11 INFO - [ 09:48:11 INFO - "pgo_build", 09:48:11 INFO - "False", 09:48:11 INFO - "Change" 09:48:11 INFO - ] 09:48:11 INFO - ], 09:48:11 INFO - "revision": "83112749ad274d0db90432f26f042d9df30eed91" 09:48:11 INFO - }, 09:48:11 INFO - { 09:48:11 INFO - "category": null, 09:48:11 INFO - "files": [ 09:48:11 INFO - { 09:48:11 INFO - "url": null, 09:48:11 INFO - "name": "https://queue.taskcluster.net/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 09:48:11 INFO - } 09:48:11 INFO - ], 09:48:11 INFO - "repository": "", 09:48:11 INFO - "rev": "967b96aa1ae114c1c2c63f73ab80c4d5b79419bf", 09:48:11 INFO - "who": "bgrinstead@mozilla.com", 09:48:11 INFO - "when": 1447951560, 09:48:11 INFO - "number": 6683627, 09:48:11 INFO - "comments": "Bug 1225967 - Fix stretched eyedropper icon in color tooltip. r=bgrins", 09:48:11 INFO - "project": "", 09:48:11 INFO - "at": "Thu 19 Nov 2015 08:46:00", 09:48:11 INFO - "branch": "fx-team-macosx64-talos", 09:48:11 INFO - "revlink": "", 09:48:11 INFO - "properties": [ 09:48:11 INFO - [ 09:48:11 INFO - "buildid", 09:48:11 INFO - "20151119071604", 09:48:11 INFO - "Change" 09:48:11 INFO - ], 09:48:11 INFO - [ 09:48:11 INFO - "builduid", 09:48:11 INFO - "d72044f35f6e4d5abbfbbc85be708d73", 09:48:11 INFO - "Change" 09:48:11 INFO - ], 09:48:11 INFO - [ 09:48:11 INFO - "pgo_build", 09:48:11 INFO - "False", 09:48:11 INFO - "Change" 09:48:11 INFO - ] 09:48:11 INFO - ], 09:48:11 INFO - "revision": "967b96aa1ae114c1c2c63f73ab80c4d5b79419bf" 09:48:11 INFO - } 09:48:11 INFO - ], 09:48:11 INFO - "revision": "967b96aa1ae114c1c2c63f73ab80c4d5b79419bf" 09:48:11 INFO - } 09:48:11 INFO - } 09:48:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 09:48:11 INFO - Running post-action listener: _resource_record_post_action 09:48:11 INFO - ##### 09:48:11 INFO - ##### Running download-and-extract step. 09:48:11 INFO - ##### 09:48:11 INFO - Running pre-action listener: _resource_record_pre_action 09:48:11 INFO - Running main action method: download_and_extract 09:48:11 INFO - mkdir: /builds/slave/test/build/tests 09:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:11 INFO - https://queue.taskcluster.net/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:48:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/test_packages.json 09:48:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/test_packages.json 09:48:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:48:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:48:12 INFO - Downloaded 1149 bytes. 09:48:12 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:48:12 INFO - Using the following test package requirements: 09:48:12 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:48:12 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:48:12 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 09:48:12 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:48:12 INFO - u'jsshell-mac.zip'], 09:48:12 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:48:12 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 09:48:12 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:48:12 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:48:12 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 09:48:12 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:48:12 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 09:48:12 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:48:12 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 09:48:12 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:48:12 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:48:12 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 09:48:12 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:12 INFO - https://queue.taskcluster.net/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:48:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:48:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:48:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/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 09:48:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/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 09:48:13 INFO - Downloaded 17522149 bytes. 09:48:13 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 09:48:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:48:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:48:16 INFO - Return code: 0 09:48:16 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 09:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:16 INFO - https://queue.taskcluster.net/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:48:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:48:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:48:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/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 09:48:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/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 09:48:17 INFO - Downloaded 17522149 bytes. 09:48:17 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 09:48:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:48:17 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:48:21 INFO - Return code: 0 09:48:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:21 INFO - https://queue.taskcluster.net/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:48:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:48:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:48:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/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 09:48:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/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 09:48:22 INFO - Downloaded 11130997 bytes. 09:48:22 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 09:48:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:48:22 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:48:22 INFO - Return code: 0 09:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:22 INFO - https://queue.taskcluster.net/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:48:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:48:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:48:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 09:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYtqdojLRyi-tlgsWVarUA/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 09:48:25 INFO - Downloaded 109364297 bytes. 09:48:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:48:25 INFO - mkdir: /builds/slave/test/properties 09:48:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:25 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:25 INFO - Contents: 09:48:25 INFO - build_url:https://queue.taskcluster.net/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:48:25 INFO - Running post-action listener: _resource_record_post_action 09:48:25 INFO - Running post-action listener: set_extra_try_arguments 09:48:25 INFO - ##### 09:48:25 INFO - ##### Running populate-webroot step. 09:48:25 INFO - ##### 09:48:25 INFO - Running pre-action listener: _resource_record_pre_action 09:48:25 INFO - Running main action method: populate_webroot 09:48:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:25 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:48:25 INFO - '../fennec_ids.txt'], 09:48:25 INFO - 'tests': ['tcheck2']}, 09:48:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:25 INFO - '--tppagecycles', 09:48:25 INFO - '7'], 09:48:25 INFO - 'tests': ['tsvgm']}}, 09:48:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:48:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:48:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:48:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:48:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:48:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:25 INFO - 'talos_options': ['--e10s'], 09:48:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:25 INFO - 'tests': ['damp', 'tps']}, 09:48:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:25 INFO - 'talos_options': ['--e10s'], 09:48:25 INFO - 'tests': ['damp', 'tps']}, 09:48:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:48:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:25 INFO - 'other': {'tests': ['a11yr', 09:48:25 INFO - 'ts_paint', 09:48:25 INFO - 'tpaint', 09:48:25 INFO - 'sessionrestore', 09:48:25 INFO - 'sessionrestore_no_auto_restore']}, 09:48:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:48:25 INFO - 'tests': ['a11yr', 09:48:25 INFO - 'ts_paint', 09:48:25 INFO - 'tpaint', 09:48:25 INFO - 'sessionrestore', 09:48:25 INFO - 'sessionrestore_no_auto_restore']}, 09:48:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:48:25 INFO - 'tests': ['a11yr', 09:48:25 INFO - 'ts_paint', 09:48:25 INFO - 'tpaint', 09:48:25 INFO - 'sessionrestore', 09:48:25 INFO - 'sessionrestore_no_auto_restore']}, 09:48:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:48:25 INFO - 'tests': ['a11yr', 09:48:25 INFO - 'ts_paint', 09:48:25 INFO - 'tpaint', 09:48:25 INFO - 'sessionrestore', 09:48:25 INFO - 'sessionrestore_no_auto_restore']}, 09:48:25 INFO - 'other_l64': {'tests': ['a11yr', 09:48:25 INFO - 'ts_paint', 09:48:25 INFO - 'tpaint', 09:48:25 INFO - 'sessionrestore', 09:48:25 INFO - 'sessionrestore_no_auto_restore']}, 09:48:25 INFO - 'other_nol64': {'tests': ['a11yr', 09:48:25 INFO - 'ts_paint', 09:48:25 INFO - 'tpaint', 09:48:25 INFO - 'sessionrestore', 09:48:25 INFO - 'sessionrestore_no_auto_restore']}, 09:48:25 INFO - 'svgr': {'tests': ['tsvgx', 09:48:25 INFO - 'tsvgr_opacity', 09:48:25 INFO - 'tart', 09:48:25 INFO - 'tscrollx', 09:48:25 INFO - 'cart']}, 09:48:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:48:25 INFO - 'tests': ['tsvgx', 09:48:25 INFO - 'tsvgr_opacity', 09:48:25 INFO - 'tart', 09:48:25 INFO - 'tscrollx', 09:48:25 INFO - 'cart']}, 09:48:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:25 INFO - 'tests': ['tp5o']}, 09:48:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:25 INFO - 'talos_options': ['--e10s'], 09:48:25 INFO - 'tests': ['tp5o']}, 09:48:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:25 INFO - 'talos_options': ['--xperf_path', 09:48:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:25 INFO - 'tests': ['tp5n']}, 09:48:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:48:25 INFO - 'talos_options': ['--e10s', 09:48:25 INFO - '--xperf_path', 09:48:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:25 INFO - 'tests': ['tp5n']}}, 09:48:25 INFO - 'talos.zip': {'path': '', 09:48:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:25 INFO - Running post-action listener: _resource_record_post_action 09:48:25 INFO - ##### 09:48:25 INFO - ##### Running create-virtualenv step. 09:48:25 INFO - ##### 09:48:25 INFO - Running pre-action listener: _resource_record_pre_action 09:48:25 INFO - Running main action method: create_virtualenv 09:48:25 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:48:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:25 INFO - Using real prefix '/tools/python27' 09:48:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:26 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:29 INFO - Installing pip.................done. 09:48:29 INFO - Return code: 0 09:48:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:29 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 0x110326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc11586d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11024a9f0>, '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 0x10ffa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/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.sKEY6ob42C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:48:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/Render', 09:48:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:29 INFO - 'HOME': '/Users/cltbld', 09:48:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:29 INFO - 'LOGNAME': 'cltbld', 09:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:29 INFO - 'MOZ_NO_REMOTE': '1', 09:48:29 INFO - 'NO_EM_RESTART': '1', 09:48:29 INFO - 'PAGER': '/bin/cat', 09:48:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:29 INFO - 'PWD': '/builds/slave/test', 09:48:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:29 INFO - 'SHELL': '/bin/bash', 09:48:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKEY6ob42C/Listeners', 09:48:29 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 09:48:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:29 INFO - 'USER': 'cltbld', 09:48:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:29 INFO - 'XPC_FLAGS': '0x0', 09:48:29 INFO - 'XPC_SERVICE_NAME': '0', 09:48:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:48:29 INFO - Cleaning up... 09:48:29 INFO - Return code: 0 09:48:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:29 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 0x110326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc11586d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11024a9f0>, '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 0x10ffa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/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.sKEY6ob42C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:48:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/Render', 09:48:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:29 INFO - 'HOME': '/Users/cltbld', 09:48:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:29 INFO - 'LOGNAME': 'cltbld', 09:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:29 INFO - 'MOZ_NO_REMOTE': '1', 09:48:29 INFO - 'NO_EM_RESTART': '1', 09:48:29 INFO - 'PAGER': '/bin/cat', 09:48:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:29 INFO - 'PWD': '/builds/slave/test', 09:48:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:29 INFO - 'SHELL': '/bin/bash', 09:48:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKEY6ob42C/Listeners', 09:48:29 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 09:48:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:29 INFO - 'USER': 'cltbld', 09:48:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:29 INFO - 'XPC_FLAGS': '0x0', 09:48:29 INFO - 'XPC_SERVICE_NAME': '0', 09:48:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:29 INFO - Downloading/unpacking psutil>=0.7.1 09:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:32 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:48:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:32 INFO - Installing collected packages: psutil 09:48:32 INFO - Running setup.py install for psutil 09:48:32 INFO - building 'psutil._psutil_osx' extension 09:48:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:48:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:48:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:48:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:48:32 INFO - building 'psutil._psutil_posix' extension 09:48:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:48:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:48:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:48:32 INFO - ^ 09:48:32 INFO - 1 warning generated. 09:48:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:33 INFO - Successfully installed psutil 09:48:33 INFO - Cleaning up... 09:48:33 INFO - Return code: 0 09:48:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x110326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc11586d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11024a9f0>, '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 0x10ffa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/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.sKEY6ob42C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:48:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/Render', 09:48:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:33 INFO - 'HOME': '/Users/cltbld', 09:48:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:33 INFO - 'LOGNAME': 'cltbld', 09:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:33 INFO - 'MOZ_NO_REMOTE': '1', 09:48:33 INFO - 'NO_EM_RESTART': '1', 09:48:33 INFO - 'PAGER': '/bin/cat', 09:48:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:33 INFO - 'PWD': '/builds/slave/test', 09:48:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:33 INFO - 'SHELL': '/bin/bash', 09:48:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKEY6ob42C/Listeners', 09:48:33 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 09:48:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:33 INFO - 'USER': 'cltbld', 09:48:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:33 INFO - 'XPC_FLAGS': '0x0', 09:48:33 INFO - 'XPC_SERVICE_NAME': '0', 09:48:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:48:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:48:35 INFO - Installing collected packages: mozsystemmonitor 09:48:35 INFO - Running setup.py install for mozsystemmonitor 09:48:35 INFO - Successfully installed mozsystemmonitor 09:48:35 INFO - Cleaning up... 09:48:35 INFO - Return code: 0 09:48:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48: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', '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 0x110326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc11586d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11024a9f0>, '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 0x10ffa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/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.sKEY6ob42C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:48: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 blobuploader==1.2.4 09:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/Render', 09:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:35 INFO - 'HOME': '/Users/cltbld', 09:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:35 INFO - 'LOGNAME': 'cltbld', 09:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:35 INFO - 'MOZ_NO_REMOTE': '1', 09:48:35 INFO - 'NO_EM_RESTART': '1', 09:48:35 INFO - 'PAGER': '/bin/cat', 09:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:35 INFO - 'PWD': '/builds/slave/test', 09:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:35 INFO - 'SHELL': '/bin/bash', 09:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKEY6ob42C/Listeners', 09:48:35 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 09:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:35 INFO - 'USER': 'cltbld', 09:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:35 INFO - 'XPC_FLAGS': '0x0', 09:48:35 INFO - 'XPC_SERVICE_NAME': '0', 09:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:36 INFO - Downloading/unpacking blobuploader==1.2.4 09:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:38 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:39 INFO - Downloading docopt-0.6.1.tar.gz 09:48:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:39 INFO - Running setup.py install for blobuploader 09:48:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:39 INFO - Running setup.py install for requests 09:48:40 INFO - Running setup.py install for docopt 09:48:40 INFO - Successfully installed blobuploader requests docopt 09:48:40 INFO - Cleaning up... 09:48:40 INFO - Return code: 0 09:48:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:40 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 0x110326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc11586d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11024a9f0>, '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 0x10ffa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/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.sKEY6ob42C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:48:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/Render', 09:48:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:40 INFO - 'HOME': '/Users/cltbld', 09:48:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:40 INFO - 'LOGNAME': 'cltbld', 09:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:40 INFO - 'MOZ_NO_REMOTE': '1', 09:48:40 INFO - 'NO_EM_RESTART': '1', 09:48:40 INFO - 'PAGER': '/bin/cat', 09:48:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:40 INFO - 'PWD': '/builds/slave/test', 09:48:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:40 INFO - 'SHELL': '/bin/bash', 09:48:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKEY6ob42C/Listeners', 09:48:40 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 09:48:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:40 INFO - 'USER': 'cltbld', 09:48:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:40 INFO - 'XPC_FLAGS': '0x0', 09:48:40 INFO - 'XPC_SERVICE_NAME': '0', 09:48:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-UjPuzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-z6S_H2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-NdAhs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-dNIMRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:40 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-0ZY0Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-9xNDfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-sj3siU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-YFHwBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-L6hb4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-0dXLHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-HXBzIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-FTylUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-6TcB9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-WM839Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:41 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-rk5z5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-4w_Gio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:42 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-_kqbyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:42 INFO - Running setup.py install for manifestparser 09:48:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozcrash 09:48:42 INFO - Running setup.py install for mozdebug 09:48:42 INFO - Running setup.py install for mozdevice 09:48:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:42 INFO - Running setup.py install for mozfile 09:48:43 INFO - Running setup.py install for mozhttpd 09:48:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozinfo 09:48:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozInstall 09:48:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozleak 09:48:43 INFO - Running setup.py install for mozlog 09:48:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for moznetwork 09:48:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:43 INFO - Running setup.py install for mozprocess 09:48:44 INFO - Running setup.py install for mozprofile 09:48:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Running setup.py install for mozrunner 09:48:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Running setup.py install for mozscreenshot 09:48:44 INFO - Running setup.py install for moztest 09:48:44 INFO - Running setup.py install for mozversion 09:48:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:44 INFO - Cleaning up... 09:48:44 INFO - Return code: 0 09:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:44 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 0x110326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc11586d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11024a9f0>, '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 0x10ffa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/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.sKEY6ob42C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/Render', 09:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:44 INFO - 'HOME': '/Users/cltbld', 09:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:44 INFO - 'LOGNAME': 'cltbld', 09:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:44 INFO - 'MOZ_NO_REMOTE': '1', 09:48:44 INFO - 'NO_EM_RESTART': '1', 09:48:44 INFO - 'PAGER': '/bin/cat', 09:48:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:44 INFO - 'PWD': '/builds/slave/test', 09:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:44 INFO - 'SHELL': '/bin/bash', 09:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKEY6ob42C/Listeners', 09:48:44 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 09:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:44 INFO - 'USER': 'cltbld', 09:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:44 INFO - 'XPC_FLAGS': '0x0', 09:48:44 INFO - 'XPC_SERVICE_NAME': '0', 09:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-acuZHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-40tTQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-3BZhSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-0zR2D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:45 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)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-kFM5fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-PKIusO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Htsme2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:45 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)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Beqz6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-qLjgUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-XbFiPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-QuU3uO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-734Xuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-lwJ5Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-cfVgqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Syn2Jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-h6xhCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:46 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-dRsXbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:48:46 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)) 09:48:46 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)) 09:48:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48: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 09:48:49 INFO - Downloading blessings-1.5.1.tar.gz 09:48:49 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:49 INFO - Installing collected packages: blessings 09:48:49 INFO - Running setup.py install for blessings 09:48:49 INFO - Successfully installed blessings 09:48:49 INFO - Cleaning up... 09:48:49 INFO - Return code: 0 09:48:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:49 INFO - Reading from file tmpfile_stdout 09:48:49 INFO - Current package versions: 09:48:49 INFO - blessings == 1.5.1 09:48:49 INFO - blobuploader == 1.2.4 09:48:49 INFO - docopt == 0.6.1 09:48:49 INFO - manifestparser == 1.1 09:48:49 INFO - mozInstall == 1.12 09:48:49 INFO - mozcrash == 0.16 09:48:49 INFO - mozdebug == 0.1 09:48:49 INFO - mozdevice == 0.47 09:48:49 INFO - mozfile == 1.2 09:48:49 INFO - mozhttpd == 0.7 09:48:49 INFO - mozinfo == 0.9 09:48:49 INFO - mozleak == 0.1 09:48:49 INFO - mozlog == 3.0 09:48:49 INFO - moznetwork == 0.27 09:48:49 INFO - mozprocess == 0.22 09:48:49 INFO - mozprofile == 0.27 09:48:49 INFO - mozrunner == 6.11 09:48:49 INFO - mozscreenshot == 0.1 09:48:49 INFO - mozsystemmonitor == 0.0 09:48:49 INFO - moztest == 0.7 09:48:49 INFO - mozversion == 1.4 09:48:49 INFO - psutil == 3.1.1 09:48:49 INFO - requests == 1.2.3 09:48:49 INFO - wsgiref == 0.1.2 09:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:49 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 0x110326490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110303228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc11586d20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11024a9f0>, '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 0x10ffa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/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.sKEY6ob42C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/Render', 09:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:49 INFO - 'HOME': '/Users/cltbld', 09:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:49 INFO - 'LOGNAME': 'cltbld', 09:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:49 INFO - 'MOZ_NO_REMOTE': '1', 09:48:49 INFO - 'NO_EM_RESTART': '1', 09:48:49 INFO - 'PAGER': '/bin/cat', 09:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:49 INFO - 'PWD': '/builds/slave/test', 09:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:49 INFO - 'SHELL': '/bin/bash', 09:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKEY6ob42C/Listeners', 09:48:49 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 09:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:49 INFO - 'USER': 'cltbld', 09:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:49 INFO - 'XPC_FLAGS': '0x0', 09:48:49 INFO - 'XPC_SERVICE_NAME': '0', 09:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:48:49 INFO - Cleaning up... 09:48:49 INFO - Return code: 0 09:48:49 INFO - Running post-action listener: _resource_record_post_action 09:48:49 INFO - Running post-action listener: _start_resource_monitoring 09:48:49 INFO - Starting resource monitoring. 09:48:49 INFO - ##### 09:48:49 INFO - ##### Running install step. 09:48:49 INFO - ##### 09:48:49 INFO - Running pre-action listener: _resource_record_pre_action 09:48:49 INFO - Running main action method: install 09:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:50 INFO - Reading from file tmpfile_stdout 09:48:50 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:50 INFO - Reading from file tmpfile_stdout 09:48:50 INFO - Output received: 09:48:50 INFO - Usage: mozinstall [options] installer 09:48:50 INFO - Options: 09:48:50 INFO - -h, --help show this help message and exit 09:48:50 INFO - -d DEST, --destination=DEST 09:48:50 INFO - Directory to install application into. [default: 09:48:50 INFO - "/builds/slave/test"] 09:48:50 INFO - --app=APP Application being installed. [default: firefox] 09:48:50 INFO - mkdir: /builds/slave/test/build/application 09:48:50 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'] 09:48:50 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 09:49:20 INFO - Reading from file tmpfile_stdout 09:49:20 INFO - Output received: 09:49:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:49:20 INFO - Running post-action listener: _resource_record_post_action 09:49:20 INFO - ##### 09:49:20 INFO - ##### Running run-tests step. 09:49:20 INFO - ##### 09:49:20 INFO - Running pre-action listener: _resource_record_pre_action 09:49:20 INFO - Running main action method: run_tests 09:49:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:49:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:49:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:49:20 INFO - 2015-11-19 09:49:20.523 screenresolution[1961:16372] starting screenresolution argv=screenresolution get 09:49:20 INFO - 2015-11-19 09:49:20.526 screenresolution[1961:16372] Display 0: 1600x1200x32@60 09:49:20 INFO - 2015-11-19 09:49:20.532 screenresolution[1962:16374] starting screenresolution argv=screenresolution list 09:49:20 INFO - Available Modes on Display 0 09:49:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:49:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:49:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:49:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:49:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:49:20 INFO - Intel Iris: 09:49:20 INFO - Chipset Model: Intel Iris 09:49:20 INFO - Type: GPU 09:49:20 INFO - Bus: Built-In 09:49:20 INFO - VRAM (Dynamic, Max): 1536 MB 09:49:20 INFO - Vendor: Intel (0x8086) 09:49:20 INFO - Device ID: 0x0a2e 09:49:20 INFO - Revision ID: 0x0009 09:49:20 INFO - Displays: 09:49:20 INFO - Display: 09:49:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:49:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:49:20 INFO - Display Serial Number: 1600x1200 60 09:49:20 INFO - Main Display: Yes 09:49:20 INFO - Mirror: Off 09:49:20 INFO - Online: Yes 09:49:20 INFO - Rotation: Supported 09:49:20 INFO - Return code: 0 09:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:20 INFO - Python 2.7.3 09:49:20 INFO - Return code: 0 09:49:20 INFO - grabbing minidump binary from tooltool 09:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:49:20 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 0x11024a9f0>, '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 0x10ffa9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11023d8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:49:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:49:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:20 INFO - Return code: 0 09:49:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:49:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:49:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:20 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/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--webServer', 'localhost'] in /builds/slave/test/build 09:49:20 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/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0062 --webServer localhost 09:49:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.v4I2osg3Rk/Render', 09:49:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:49:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:49:20 INFO - 'HOME': '/Users/cltbld', 09:49:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:49:20 INFO - 'LOGNAME': 'cltbld', 09:49:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:20 INFO - 'MOZ_NO_REMOTE': '1', 09:49:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:20 INFO - 'NO_EM_RESTART': '1', 09:49:20 INFO - 'PAGER': '/bin/cat', 09:49:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:20 INFO - 'PWD': '/builds/slave/test', 09:49:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:49:20 INFO - 'SHELL': '/bin/bash', 09:49:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sKEY6ob42C/Listeners', 09:49:20 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 09:49:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:49:20 INFO - 'USER': 'cltbld', 09:49:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:49:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:20 INFO - 'XPC_FLAGS': '0x0', 09:49:20 INFO - 'XPC_SERVICE_NAME': '0', 09:49:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:49:20 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/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--webServer', 'localhost'] with output_timeout 3600 09:49:21 INFO - mozversion INFO | application_buildid: 20151119071604 09:49:21 INFO - mozversion INFO | application_changeset: 967b96aa1ae114c1c2c63f73ab80c4d5b79419bf 09:49:21 INFO - mozversion INFO | application_display_name: Nightly 09:49:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:21 INFO - mozversion INFO | application_name: Firefox 09:49:21 INFO - mozversion INFO | application_remotingname: firefox 09:49:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:49:21 INFO - mozversion INFO | application_vendor: Mozilla 09:49:21 INFO - mozversion INFO | application_version: 45.0a1 09:49:21 INFO - mozversion INFO | platform_buildid: 20151119071604 09:49:21 INFO - mozversion INFO | platform_changeset: 967b96aa1ae114c1c2c63f73ab80c4d5b79419bf 09:49:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:49:21 INFO - mozversion INFO | platform_version: 45.0a1 09:49:21 INFO - 2015-11-19 09:49:21,068 DEBUG : using testdate: 1447955361 09:49:21 INFO - 2015-11-19 09:49:21,068 DEBUG : actual date: 1447955361 09:49:21 INFO - 2015-11-19 09:49:21,079 INFO : starting webserver on 'localhost:51234' 09:49:21 INFO - 2015-11-19 09:49:21,080 INFO : Starting test suite t-yosemite-r7-0062 09:49:21 INFO - 2015-11-19 09:49:21,080 INFO : Starting test dromaeo_css 09:49:21 INFO - 2015-11-19 09:49:21,080 DEBUG : operating with platform_type : mac_ 09:49:21 INFO - 2015-11-19 09:49:21,081 INFO : Initialising browser for dromaeo_css test... 09:49:21 INFO - 2015-11-19 09:49:21,093 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmp85AU5j/profile http://localhost:51234/getInfo.html 09:49:23 INFO - 2015-11-19 09:49:23,335 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:49:23 INFO - 2015-11-19 09:49:23,335 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:49:23 INFO - 2015-11-19 09:49:23,335 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:49:23 INFO - 2015-11-19 09:49:23,336 DEBUG : BROWSER_OUTPUT: __metrics 09:49:23 INFO - 2015-11-19 09:49:23,351 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:49:23 INFO - 2015-11-19 09:49:23,663 DEBUG : BROWSER_OUTPUT: console.error: 09:49:23 INFO - 2015-11-19 09:49:23,666 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 09:49:23 INFO - 2015-11-19 09:49:23,666 DEBUG : BROWSER_OUTPUT: Stack: 09:49:23 INFO - 2015-11-19 09:49:23,666 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 09:49:23 INFO - 2015-11-19 09:49:23,666 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 09:49:23 INFO - 2015-11-19 09:49:23,667 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 09:49:23 INFO - 2015-11-19 09:49:23,667 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 09:49:23 INFO - 2015-11-19 09:49:23,667 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 09:49:23 INFO - 2015-11-19 09:49:23,667 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 09:49:23 INFO - 2015-11-19 09:49:23,667 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 09:49:23 INFO - 2015-11-19 09:49:23,667 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 09:49:23 INFO - 2015-11-19 09:49:23,667 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 09:49:23 INFO - 2015-11-19 09:49:23,667 DEBUG : BROWSER_OUTPUT: 09:49:24 INFO - 2015-11-19 09:49:24,134 INFO : Browser initialized. 09:49:24 INFO - 2015-11-19 09:49:24,134 INFO : Running cycle 1/1 for dromaeo_css test... 09:49:24 INFO - 2015-11-19 09:49:24,134 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmp85AU5j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:49:36 INFO - 2015-11-19 09:49:36,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 224735232 09:49:36 INFO - 2015-11-19 09:49:36,074 DEBUG : BROWSER_OUTPUT: 09:50:33 INFO - 2015-11-19 09:50:33,310 DEBUG : BROWSER_OUTPUT: 1447955433309 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:52:38 INFO - 2015-11-19 09:52:38,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51234/tests/dromaeo/cssquery-ext.html) 09:52:40 INFO - 2015-11-19 09:52:40,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 386199552 09:52:40 INFO - 2015-11-19 09:52:40,246 DEBUG : BROWSER_OUTPUT: 09:55:43 INFO - 2015-11-19 09:55:43,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/dromaeo/cssquery-ext.html (next: http://localhost:51234/tests/dromaeo/cssquery-jquery.html) 09:55:43 INFO - 2015-11-19 09:55:43,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 364539904 09:55:43 INFO - 2015-11-19 09:55:43,666 DEBUG : BROWSER_OUTPUT: 09:58:45 INFO - 2015-11-19 09:58:45,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51234/tests/dromaeo/cssquery-mootools.html) 09:58:46 INFO - 2015-11-19 09:58:46,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 347779072 09:58:46 INFO - 2015-11-19 09:58:46,348 DEBUG : BROWSER_OUTPUT: 10:01:48 INFO - 2015-11-19 10:01:48,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51234/tests/dromaeo/cssquery-prototype.html) 10:01:48 INFO - 2015-11-19 10:01:48,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 327561216 10:01:48 INFO - 2015-11-19 10:01:48,935 DEBUG : BROWSER_OUTPUT: 10:04:51 INFO - 2015-11-19 10:04:51,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51234/tests/dromaeo/cssquery-yui.html) 10:04:52 INFO - 2015-11-19 10:04:52,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 327348224 10:04:52 INFO - 2015-11-19 10:04:52,364 DEBUG : BROWSER_OUTPUT: 10:07:55 INFO - 2015-11-19 10:07:55,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/dromaeo/cssquery-yui.html (next: http://localhost:51234/tests/dromaeo/cssquery-dojo.html) 10:07:55 INFO - 2015-11-19 10:07:55,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 379637760 10:07:55 INFO - 2015-11-19 10:07:55,353 DEBUG : BROWSER_OUTPUT: 10:07:55 INFO - 2015-11-19 10:07:55,353 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:07:55 INFO - 2015-11-19 10:07:55,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:07:55 INFO - 2015-11-19 10:07:55,353 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:07:55 INFO - 2015-11-19 10:07:55,353 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:07:55 INFO - 2015-11-19 10:07:55,353 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2485.242001189637;3577.9105522361956;3590.8922732318038;3597.298526787274;3614.3494171049215;5857.970710146444;6006.159137720711;6084.878302433949;6114.663693496856;6152.784652537168;6087.695615219232;6099.491378240913;6113.174721412608;6117.694115294229;6125.08123781433;5395.460453954613;5415.268938693265;5442.074847275972;5482.259894914176;5525.972370138144;4977.676451030671;5140.563052140573;5518.91721624176;5520.309961254843;5527.585431092664;4583.266677331628;5488;5491.670499770006;5507.256520369739;5520.558355331564;5473.972630136824;5501.9174712379345;5503.147012213113;5522.199281104257;5535.335759708861;4466.374707540915;5325.414204437548;5334.333208348957;5446.945530544684;5454.481824226692;5985.551083668699;6039.335673075958;6041.1240370146525;6063.484603808682;6066.514678825683;6277.780277690259;6334.1765570476;6354.205724284465;6359.109724638554;6359.65021923794;6234.844128896769;6312.274088479838;6326.398992095789;6333.271673757531;6385.936140638581;6141.877162456771;6166.075088736726;6218.751249950042;6221;6225.595336303126;6578.671066446658;6653.334666533308;6654.26803051664;6658.83352916181;6659.766908158192;5649.887002260014;6224.439800417984;6230.56386052981;6365.077063825719;6379.681015949277;6408.295087540367;6413.839654008687;6415.454686351713;6420.550561460746;6434.2600600930555;6221.471174950089;6360.204974378203;6360.745570177233;6372.299047104908;6380.106785050097;6221.782237621662;6299.338569450233;6343.175387199727;6347.587406818542;6377.649229292433;5119.10415677255;5119.488051194925;5135.229715542699;5139.820106296262;5140.254663073833;4580.977095114503;4601.907961840744;4605.953940460619;4607.8848028798875;4622.445306563234;5971.820845374646;6029.336772954972;6047.882393421571;6088;6124;6416.518761092937;6447.967760161169;6455.257645370749;6477.384648458389;6487.0269459580495;6198.81403557894;6202.782902598387;6209.0996805462955;6212.254529456494;6219.595726277777;5495.148252020943;5567.164925261243;5603.887922241533;5604.635698679573;5671.971640141773;6607;6664.66676666155;6669.233038200669;6672.065910772592;6678.866422671422;6391.48868090561;6424.807255782334;6435.324290949383;6454.419102280817;6456.7740129095255;6379.425851673372;6438.90341644885;6444.387783160592;6538.378854008862;6641.833954151185;6306.905396419149;6327.272363678236;6368.808935731936;6368.936310637019;6374.649394283359;6302.810915672537;6402.487800975818;6403.807885763435;6404.455621272244;6412.647304398303;5639;6172.938270617236;6337.6197428154455;6365.649889256136;6366.172397588284;6210.192674952227;6340.239171299474;6343;6353.968230159005;6377.1390862233;6305.148804911279;6343.365663433619;6348.904766428415;6361.650109244036;6364.427201551883;6286.497080233662;6328.7152078157515;6336.20797400325;6345.302016778059;6359.395857393541;6135.141080248858;6196.47329976939;6197.442230199304;6366.96816515933;6367.013112967497 10:07:55 INFO - 2015-11-19 10:07:55,354 DEBUG : BROWSER_OUTPUT: |1;ext.html;555.111821086262;558.290970467506;582.2954225387281;603.3604379357881;631.4033238589535;31796.68203317969;32263.83868080659;39064.60935390649;40294;40376.39435408471;43236;43510.564894351046;43710;43737.56262437375;43757.56242437575;8792.42849214799;9761.951190244039;9944.552495137736;9975.50122493876;9982.351147175446;8753;8832.249258813008;11893.989010934081;11940.402979850973;11955.820662690066;11675.299482031063;11747.177697561174;11751.941240293787;11755.588554400598;11767.411629418495;8887.955560222157;8994.685186018523;11901.642950711535;11910.34493102879;11911.583094591691;11846.585369512111;11941.402929853559;11955.64133076009;11964.64106076819;11969.162158648898;40155.19689606191;40534.594654053675;40553;40679.186416271805;40739.7963010186;3151.558781770554;3286.5234540991423;3308.520264561649;3365;3560.8753693620597;29117.272068198254;29444.55833162483;29490;29771.404571908657;30338.69661303403;2590.352411897026;2591.157873691058;2609.4389706213256;2649.297936046949;2683.6645419322585;499311;503152;504238.47880760726;504779;504973;59580.70209649011;60663;60962.695186523786;65386;66951.99572006424;63482;64079.679601601696;64385.35614643887;64401;64508;15915.363385464452;16050.438234661731;16070.839291607168;16072.357105715875;16081.839181608035;12701.174423662433;12752.617421477371;12764.234145951086;12885.549005784753;12887.420066097047;20169.294074707315;20350.18599256043;20386.796132038788;20396;20441.897790510953;8465.66137354499;8564.571771411405;8571.228589426857;8626.741197764077;8729.08344623818;875.146731936357;929.7582628516634;1076.8923107689325;1086.9728256793485;1138.231693606812;29420.411591768472;29432.55851162234;29762.404751905273;30123.096307110824;30233.09300720938;1046.2467023742893;1047.0314958663207;1081.2485322700804;1109.8279766636185;1165.3998190931677;12478.563250286197;14517;14539.3457294422;15429.691406172038;15488;473541;480101;480218;480325;482337.5883120562;50725.23912141321;51312.74343628332;58131.128033079534;58310;61882;1492.962675933067;1494.1632685696045;1497.1915165810558;1508.5172744721583;1531.9888873343762;30677.23306917345;30739.846300768353;30759;31489.685103148677;31544.36911261716;46767;47484.812879678284;51888.702782430744;53336.73331633317;53378.19932700935;396116.0388396079;449104;450608;451117;451633;26551.867240663672;33103.855133762256;33347.66652333543;33487.82792602247;33491.83254083714;42403.1519369617;43060.35409468798;43085.56914430815;43104;43418;37052.268042780255;37461;37902.8104859474;38255.617443825206;38257.6174238254;36366;36888.12836346566;37343.6265637351;37534.8123259382;37584.43623345707;36087.44383499134;36807.07982300464;36976.890693279245;37188.81405592955;37333.81333093317;32167.678323217406;33513.83243083769;34930.65069349274;35539.82230088936;35906.10234744152;24412.63381049321;24753;24763.752362476866;25430.109946151795;32698 10:07:55 INFO - 2015-11-19 10:07:55,358 DEBUG : BROWSER_OUTPUT: |2;jquery.html;309.7212508742132;360.70962874885726;364.56252497003595;364.8175912043978;364.8248840556533;12654.810177847317;16633.83366166338;19777.30779422719;20460.69308960365;21347.893260533674;20694.275700350492;20763.065662045206;21161.68257476135;21164.730116193;21185.57628847422;5972.581919265654;6166;6167.074938759177;6173.043178307369;6175.197224360849;4420.447444069491;4546.499885012646;4563.566461186182;6072.180255665473;6643.269240383554;5692.402297758737;6589.868202635945;6755.8311042224095;6775.424088952445;6788.830279243034;6733.730650773963;6772.966135169293;6779.7966061018005;6780.694868730919;6782.253952065269;5776.162456443834;5905.438983296623;5912.911306330366;5936.376680448534;5939.168516407706;26155.215343539534;26373.68131593432;27136.32159196016;27177.86411067952;27791.305217369525;2089.268755935426;2094.937151885446;2400.5558971590135;2658.787297016234;2705.0397109026408;15061.548153555412;15377.154256515887;15624.140672263022;15640.921795391065;15845.038919209086;1328.9136206146666;1681.0166052859092;1739.2173521915063;1762.4536393717988;1783.7591925090076;103154;105283;105502.99999999923;106993.46503267511;108210.91789082087;11669;11959.880401196051;11959.940200299117;11979.580714674945;12060.75878482443;14349.852011839028;14444;14467.27663616836;14475.203863787592;14499.637509062148;9048.819023619491;9083.18251357381;9088;9093.31800114994;9158.221551168092;7349.63251837406;9084.500352480676;9104.362694611315;9204.63181472747;9205.493697846683;6669.233038200669;6705.027770973182;6706.094677218611;6719.932800671931;6731.663416829139;1696.8291878603725;1742.392387899629;1787.6156626325403;1873.4660621722744;1940.706695189916;424.3359142941287;430.341577386599;446.23025281389346;461.15608436561683;485.60908468682345;11021.504032318566;12371.628851134481;12486.562970295996;12581.937090314674;12812.487500499876;426.3051226500784;462.87502374358735;469.6594968647703;491.6214514823566;505.8887044850127;6126.172966649535;6625.469962402996;6691.297413771581;6696.296888826603;6708.295628958889;760363;762728;764626;778193;781528;110184;114544.42727786474;116947;118222;122468.77531224753;511.5702809639846;528.0468753899248;529.5498825997871;529.7721979548832;530.2020459208943;11753.059755219732;11797.17419780607;11957.940210298893;11967.700807479534;11973.640790776291;34911.825440872635;37807.62192378041;47263.05473890434;48855.51144488652;48862.23267304539;65882;67638.66180669065;72231;72924;73077.53844923178;6287.245530536182;6522.934770652233;6525.119108920235;6529.934700652932;6533.346665333429;12237.571684990982;12478.625641230778;12567.87432125667;12598;12611.621651350475;10803;11042.006219440289;11072.667819965414;11114.44427778624;11145;10539.473026348498;10753.946230269112;10875.07561857251;10904.727381815517;11081.27971681838;9456.763580910532;9716.951415242878;9724.562394692115;9751.902480975383;10885.455727213766;6377.713002914973;6489.702059588196;6539.771108011387;6546.967265163644;6571.277159512354;10957.945210273898;11069.169812263952;11235.775284494428;11270.042046426146;11377.772444550897 10:07:55 INFO - 2015-11-19 10:07:55,359 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1546.845315468454;1547.473858887978;1656.5196093132993;1872.9698665733847;1874.5126267170535;7304.488685791996;7610.277023682748;8091.474054186481;8333.041700204478;8340.83318333633;8120.715774947863;8194.385421093411;8241.670333186681;8244.83510329793;8272.338212942965;2360.2683168217823;2384.2608791274674;2387.1167667962877;2387.928362149138;2389.2115601851347;2360.9645855312183;2377.8454400464;2401.8438801477937;2402.8318017738766;2414.95170096598;2331.6968794056747;2354.0466111224982;2358.5400846834787;2362.303120579433;2368.0882860098814;2329.6389059695775;2356.8350215484925;2366.8343215974974;2368.3842201027683;2368.4789346343778;2373.2049763329305;2393.4136136646634;2399.3881560202212;2406.446517301013;2406.6871306730186;7232.855342893113;8244.670213191464;8276.83446331076;8282.461639993442;8285.25432711059;4463.419755431773;4544.931826022612;4990.426100998359;5099.796008159669;5110.105731496973;2973.925651858699;3520.5775306963073;3576.7317451191007;3599.406097993828;3600.945985810215;964.9372790768648;1021.687132035331;1038.4485061091086;1060.8461773042943;1089.4171618184234;10867.184961127947;10925.672229833117;10948.507317170746;10953;10964.780704385868;4527.230370836965;4637.8840528986375;4711.693739906895;4779.498152693986;4781.497942716034;8903.465792052497;9021.233195178353;9036.45781253127;9045.231155351737;9064.365494415459;5091.516305950929;5093.363329583802;5106.974465127651;5116.820911268088;5122.257272695439;4662.7668616569035;4735.881602959954;4736.905261894743;4743.928841067387;4753.738544380023;3450.741194410429;3608.476770868262;3612.2414292998237;3637.308911306843;3649.069487280726;1127.7969965406141;1129.48043899807;1132.7791080739178;1138.6527109231763;1140.2531341971023;1347.4206091380604;1360.3130419138272;1382.5852244326863;1393.4217299820664;1393.6306878677158;7719.150893401721;7721.343685786659;7742.806429839299;7852.371810255166;7877.842443151105;492.83736366998806;499.60780787081967;500.6770632941805;502.7260143221953;511.2510172597163;5684;5808.419158084243;6130.295016073209;6209.223847019122;6228.096925945712;9118.270538356915;9795.951020244996;9810.803783924424;9903.554340054714;9922.255830812717;9558.474283914313;9657;9797.853032204523;9816.116549510578;9830.852537211947;7792.727254546177;7902.051753789582;7902.407319450949;7906.327962123284;7908.406869484812;7717.459777815724;7758.030246219223;7793.493422927719;7814;7831.804204894923;8717.65129394817;8870.866936996079;8991.55042247898;9018.23345015681;9114.908850911672;9149.222316103205;9280.535973201448;9387.014363491735;9400.858987115336;9443.527823608929;7047.788566343018;7098.183708873546;7321.853562928605;7416.332530072319;7427;7884.605769711607;7920.84158316842;7937.2459616336355;7939.920600793918;7951.483153594998;6450.258430223907;7332.560046397233;7471.701131954661;7584.810379740551;7589.43079269046;7272.454565907684;7272.781816545512;7278.126624805057;7402.1117465904435;7404.148522919933;7103.893441598483;7512.774616761506;7528.887066693895;7530.134034585873;7543.170251272246;6831.11195544576;6864.965675171592;6884.139482564679;6890.414314783099;6902.171739391104;5997.460228579449;6809.012693159563;6955.582665040114;6955.930440695731;6959.234484206632 10:07:55 INFO - 2015-11-19 10:07:55,362 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.3007313982379;319.8464736926275;328.70252421558484;330.39042965728254;333.8914852672883;6698.564593301432;6734.057231987519;6779.62712050837;6779.694913728882;6814.931850681492;6683.465322774178;6709.926411774117;6710.825605519039;6727;6730.96634516828;3960.544537378202;4952.232403977389;4976.278439626252;4980.6762560433635;4982.277569752384;4715.834945776881;4895.657303988723;4898.902021959559;4921.704697718131;4923.089228492722;4218.713292445803;4569.13186494565;4844.491328410501;4849.951500485003;4859.343988561534;4598.655100867415;4705.858824235278;4728.432588089417;4844.297576851354;4869.610431165498;3339.682730140657;4009.1781184857327;4033.3748269018347;4125.546189919107;4131.194417088669;6326.5255105867245;6327.335629758901;6331.968340158316;6350.206224221973;6387.498937749625;5435.510804027617;5553.611247212697;5686.232358631573;5695.5443564514735;5767.1637612546365;6601.3068627794355;6964.4428445724225;7023.89464158038;7150.356467917913;7210.2789721028;4604.240300350438;4616.838410655611;4628.722276663411;4629.421322334708;4633.698809577367;7477.140128885139;7573.053368328904;7573.318401343906;7582.469227154046;7583.62081895903;4543.227651299287;4660;4679.549339704702;4689.929651055237;4701.95298047022;4781.617470602343;4782.689125206851;4783.808647654055;4789.808407663724;4791.520847915181;5703.144528320702;5708.628939118944;5710.343310519261;5715.599908006483;5721.856953576111;6978.197507286727;7129.322714342129;7156.427485801123;7173.964130179315;7181.856362872818;1637.5742307000028;1659.96680066398;1661.534770264328;1661.534770264328;1662.534490342706;1055;1055.3562326980536;1060.9151267898549;1068.2255364860569;1081.751197224627;6624.7681331154145;6646.069550262967;6647.268800431949;6653.604702307165;6657.633830139389;5961.403859614091;7322.816929576803;7347.669354879044;7355.1541572719825;7358.374538164209;6340.492760579143;6586.670666466657;6588.4729221662155;6592.76925307612;6624.27133015368;3735.159589092487;3813.637704418076;3880.708946828999;3916.804159791999;3925.450436938831;7441.8139546511775;7488.4009279257525;7609.429292803062;7688.461807673521;7694.499857509244;7614.124375696755;7662.195469475736;7663.348615367756;7668.118166410823;7668.769936901902;7548.8490230196185;7661.961690191513;7730.265624765526;7752.14726380109;7762.107357653942;7369.410447164321;7397.630118494161;7401.0748656417945;7410.740624078131;7413.666385012795;7096.042034325506;7320.9267907320245;7341.816454588678;7342.743003994835;7351.117865856131;7687.692492300245;7780.961095194488;7781.144074151725;7798.961005194938;7804.9219507806465;4655;4700.529947005409;4703.506131856243;4707.529247075265;4710.479893257091;7132.322429369202;7378.335949764547;7380.815479612837;7382.483226174117;7395.593242371721;6089.842929843316;6863.245043045161;7141.857162856818;7143.535670181422;7156.141263048467;7130.251323611154;7131.179914309921;7135.751243532257;7137.82155446118;7138.8215294615975;6775.559588626724;6932.746857271508;6966.756163534252;6982.685779140053;6987.301269872972;7127.8574428512175;7128;7131.572105673468;7132.393746531603;7136.643167841691;6805.455563555002;6980.930190698028;6986.510944233854;6989.825254368681;7087.574745515286 10:07:55 INFO - 2015-11-19 10:07:55,363 DEBUG : BROWSER_OUTPUT: |5;yui.html;723.8841785314344;728.0317178153053;735.9374453171481;800.0759123212691;868.4789126524084;12444.751104977917;14479;14922.850771492282;14943.028703134289;14952.476663316786;11999.940000300008;13858.4456621735;13929.582112536615;14027.579172624837;14306.713865722679;763.3282711214124;962.41292811385;987.3582171588489;989.3074847606669;990.400807511456;779.6452614060589;793.2543409195338;970.0348153587155;997.5211898288826;998.7053819123377;1021.2646894236138;1027.6916924922493;1037.9117774989097;1037.9117774989136;1038.2939601071268;795.1372760554805;816.2531283875247;1019.0624625344701;1027.2193133218732;1029.9485025748684;601.2004034633926;603.471962033221;737.819234287603;756.916739158692;761.9466637335389;12320.445579948924;14722.852771472255;14731.926340368336;14781.704365912728;14789.11265324084;12059.819102713467;12180.878191218064;12385.814212786816;12450.128491005633;12537.811932821014;9399.201067909236;9512.95243523778;9529.190018848407;9670.613175472972;9827.90172098277;3260.6250281217726;3574.874879379235;3597.6941959933174;3606;3629.0201645555553;70246.2438439038;70468;70635;72394.63802680952;72520.54958900792;7105.502614816914;7578;9632.325737198329;9651.324407291422;9950.850737238947;10866.45667716611;12683.23900565969;12847.421866016051;12858.421371038326;12903.290319032543;6541.411272985454;6614.98243035869;6716.059751634775;6796;6941.7223311068;3939.9212015759526;4053.4527838741983;4054.351303791379;4058.837646494107;4204.768737719393;3232.8383580820864;3265.804051756902;3269.5613929871256;3276.0335700967794;3276.7542434317043;502.8516587606665;511.9939319237716;514.4495389932811;517.1647788821027;520.0794593569361;474.8371169323763;477.36748807829764;495.2398068964123;503.2250334484925;526.9077911365496;6771.424428923498;8495.957520212483;8562.100979397073;8708.259797917248;8792.558618708412;432.90908909129433;541.7264281537877;545.4082320682104;631.5515983651567;633.2654121219364;3616.8191590420374;3833.501644786216;4166.6666666666715;4229.111886503807;4344.739315641008;93666;93819;94518.52740736252;96458;99826;84192;89151;89233;89848;89979;58659.70670146622;66120.66939665271;76307;77215.61392193002;77769.61115194387;8436.53599052058;9023.909760902307;9065.02891611833;9131.634734610807;9334.25325973934;41522.99999999879;49804.00391992212;52467.21299180439;53957.730211348695;54584;74112.25887741054;76219.61890190735;77351.2264877344;78204.60897695702;78483;8054.114047454893;8178.059523154913;8193.385496087936;8209;8251.504909705436;12118.878811211775;12238.75522489563;12618.621441356774;12676.809847852106;13029.609111726664;11929.701757456132;11954.462049207981;12049.81925271104;12083.275003499819;12115.636530904087;11342.60300889465;11369.715757105807;11432.142589306002;11559.711007224887;11915.16593838423;9696.515174241118;11255.324680519196;11836.408179591159;11845.703857403634;12285.140040197459;9347;9481.141904563374;9684.225261979165;10079.748006299902;10320.896791032294;7885.2114788520685;7910.406719495946;10023.46232663118;10139.543720532447;10310.32982856112 10:07:55 INFO - 2015-11-19 10:07:55,364 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:07:55 INFO - 2015-11-19 10:07:55,364 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:07:55 INFO - 2015-11-19 10:07:55,364 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1404 10:07:55 INFO - 2015-11-19 10:07:55,364 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:07:55 INFO - 2015-11-19 10:07:55,364 DEBUG : BROWSER_OUTPUT: __startTimestamp1447956475349__endTimestamp 10:07:55 INFO - 2015-11-19 10:07:55,364 DEBUG : BROWSER_OUTPUT: 10:07:55 INFO - 2015-11-19 10:07:55,365 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:07:55 INFO - 2015-11-19 10:07:55,365 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:07:55 INFO - 2015-11-19 10:07:55,365 DEBUG : BROWSER_OUTPUT: 10:07:55 INFO - 2015-11-19 10:07:55,365 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5966.83 Median:6221.78 stddev:686.63 (11.0%) stddev-sans-first:632.09 10:07:55 INFO - 2015-11-19 10:07:55,365 DEBUG : BROWSER_OUTPUT: Values: 2485.2 3577.9 3590.9 3597.3 3614.3 5858.0 6006.2 6084.9 6114.7 6152.8 6087.7 6099.5 6113.2 6117.7 6125.1 5395.5 5415.3 5442.1 5482.3 5526.0 4977.7 5140.6 5518.9 5520.3 5527.6 4583.3 5488.0 5491.7 5507.3 5520.6 5474.0 5501.9 5503.1 5522.2 5535.3 4466.4 5325.4 5334.3 5446.9 5454.5 5985.6 6039.3 6041.1 6063.5 6066.5 6277.8 6334.2 6354.2 6359.1 6359.7 6234.8 6312.3 6326.4 6333.3 6385.9 6141.9 6166.1 6218.8 6221.0 6225.6 6578.7 6653.3 6654.3 6658.8 6659.8 5649.9 6224.4 6230.6 6365.1 6379.7 6408.3 6413.8 6415.5 6420.6 6434.3 6221.5 6360.2 6360.7 6372.3 6380.1 6221.8 6299.3 6343.2 6347.6 6377.6 5119.1 5119.5 5135.2 5139.8 5140.3 4581.0 4601.9 4606.0 4607.9 4622.4 5971.8 6029.3 6047.9 6088.0 6124.0 6416.5 6448.0 6455.3 6477.4 6487.0 6198.8 6202.8 6209.1 6212.3 6219.6 5495.1 5567.2 5603.9 5604.6 5672.0 6607.0 6664.7 6669.2 6672.1 6678.9 6391.5 6424.8 6435.3 6454.4 6456.8 6379.4 6438.9 6444.4 6538.4 6641.8 6306.9 6327.3 6368.8 6368.9 6374.6 6302.8 6402.5 6403.8 6404.5 6412.6 5639.0 6172.9 6337.6 6365.6 6366.2 6210.2 6340.2 6343.0 6354.0 6377.1 6305.1 6343.4 6348.9 6361.7 6364.4 6286.5 6328.7 6336.2 6345.3 6359.4 6135.1 6196.5 6197.4 6367.0 6367.0 10:07:55 INFO - 2015-11-19 10:07:55,365 DEBUG : BROWSER_OUTPUT: 10:07:55 INFO - 2015-11-19 10:07:55,365 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:62556.06 Median:35996.77 stddev:125972.96 (350.0%) stddev-sans-first:126240.34 10:07:55 INFO - 2015-11-19 10:07:55,366 DEBUG : BROWSER_OUTPUT: Values: 555.1 558.3 582.3 603.4 631.4 31796.7 32263.8 39064.6 40294.0 40376.4 43236.0 43510.6 43710.0 43737.6 43757.6 8792.4 9762.0 9944.6 9975.5 9982.4 8753.0 8832.2 11894.0 11940.4 11955.8 11675.3 11747.2 11751.9 11755.6 11767.4 8888.0 8994.7 11901.6 11910.3 11911.6 11846.6 11941.4 11955.6 11964.6 11969.2 40155.2 40534.6 40553.0 40679.2 40739.8 3151.6 3286.5 3308.5 3365.0 3560.9 29117.3 29444.6 29490.0 29771.4 30338.7 2590.4 2591.2 2609.4 2649.3 2683.7 499311.0 503152.0 504238.5 504779.0 504973.0 59580.7 60663.0 60962.7 65386.0 66952.0 63482.0 64079.7 64385.4 64401.0 64508.0 15915.4 16050.4 16070.8 16072.4 16081.8 12701.2 12752.6 12764.2 12885.5 12887.4 20169.3 20350.2 20386.8 20396.0 20441.9 8465.7 8564.6 8571.2 8626.7 8729.1 875.1 929.8 1076.9 1087.0 1138.2 29420.4 29432.6 29762.4 30123.1 30233.1 1046.2 1047.0 1081.2 1109.8 1165.4 12478.6 14517.0 14539.3 15429.7 15488.0 473541.0 480101.0 480218.0 480325.0 482337.6 50725.2 51312.7 58131.1 58310.0 61882.0 1493.0 1494.2 1497.2 1508.5 1532.0 30677.2 30739.8 30759.0 31489.7 31544.4 46767.0 47484.8 51888.7 53336.7 53378.2 396116.0 449104.0 450608.0 451117.0 451633.0 26551.9 33103.9 33347.7 33487.8 33491.8 42403.2 43060.4 43085.6 43104.0 43418.0 37052.3 37461.0 37902.8 38255.6 38257.6 36366.0 36888.1 37343.6 37534.8 37584.4 36087.4 36807.1 36976.9 37188.8 37333.8 32167.7 33513.8 34930.7 35539.8 35906.1 24412.6 24753.0 24763.8 25430.1 32698.0 10:07:55 INFO - 2015-11-19 10:07:55,367 DEBUG : BROWSER_OUTPUT: 10:07:55 INFO - 2015-11-19 10:07:55,367 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38211.76 Median:364.82 stddev:126716.10 (34733.7%) stddev-sans-first:127039.60 10:07:55 INFO - 2015-11-19 10:07:55,368 DEBUG : BROWSER_OUTPUT: Values: 309.7 360.7 364.6 364.8 364.8 12654.8 16633.8 19777.3 20460.7 21347.9 20694.3 20763.1 21161.7 21164.7 21185.6 5972.6 6166.0 6167.1 6173.0 6175.2 4420.4 4546.5 4563.6 6072.2 6643.3 5692.4 6589.9 6755.8 6775.4 6788.8 6733.7 6773.0 6779.8 6780.7 6782.3 5776.2 5905.4 5912.9 5936.4 5939.2 26155.2 26373.7 27136.3 27177.9 27791.3 2089.3 2094.9 2400.6 2658.8 2705.0 15061.5 15377.2 15624.1 15640.9 15845.0 1328.9 1681.0 1739.2 1762.5 1783.8 103154.0 105283.0 105503.0 106993.5 108210.9 11669.0 11959.9 11959.9 11979.6 12060.8 14349.9 14444.0 14467.3 14475.2 14499.6 9048.8 9083.2 9088.0 9093.3 9158.2 7349.6 9084.5 9104.4 9204.6 9205.5 6669.2 6705.0 6706.1 6719.9 6731.7 1696.8 1742.4 1787.6 1873.5 1940.7 424.3 430.3 446.2 461.2 485.6 11021.5 12371.6 12486.6 12581.9 12812.5 426.3 462.9 469.7 491.6 505.9 6126.2 6625.5 6691.3 6696.3 6708.3 760363.0 762728.0 764626.0 778193.0 781528.0 110184.0 114544.4 116947.0 118222.0 122468.8 511.6 528.0 529.5 529.8 530.2 11753.1 11797.2 11957.9 11967.7 11973.6 34911.8 37807.6 47263.1 48855.5 48862.2 65882.0 67638.7 72231.0 72924.0 73077.5 6287.2 6522.9 6525.1 6529.9 6533.3 12237.6 12478.6 12567.9 12598.0 12611.6 10803.0 11042.0 11072.7 11114.4 11145.0 10539.5 10753.9 10875.1 10904.7 11081.3 9456.8 9717.0 9724.6 9751.9 10885.5 6377.7 6489.7 6539.8 6547.0 6571.3 10957.9 11069.2 11235.8 11270.0 11377.8 10:07:55 INFO - 2015-11-19 10:07:55,368 DEBUG : BROWSER_OUTPUT: 10:07:55 INFO - 2015-11-19 10:07:55,368 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5728.57 Median:6629.64 stddev:2971.45 (44.8%) stddev-sans-first:2963.16 10:07:55 INFO - 2015-11-19 10:07:55,369 DEBUG : BROWSER_OUTPUT: Values: 1546.8 1547.5 1656.5 1873.0 1874.5 7304.5 7610.3 8091.5 8333.0 8340.8 8120.7 8194.4 8241.7 8244.8 8272.3 2360.3 2384.3 2387.1 2387.9 2389.2 2361.0 2377.8 2401.8 2402.8 2415.0 2331.7 2354.0 2358.5 2362.3 2368.1 2329.6 2356.8 2366.8 2368.4 2368.5 2373.2 2393.4 2399.4 2406.4 2406.7 7232.9 8244.7 8276.8 8282.5 8285.3 4463.4 4544.9 4990.4 5099.8 5110.1 2973.9 3520.6 3576.7 3599.4 3600.9 964.9 1021.7 1038.4 1060.8 1089.4 10867.2 10925.7 10948.5 10953.0 10964.8 4527.2 4637.9 4711.7 4779.5 4781.5 8903.5 9021.2 9036.5 9045.2 9064.4 5091.5 5093.4 5107.0 5116.8 5122.3 4662.8 4735.9 4736.9 4743.9 4753.7 3450.7 3608.5 3612.2 3637.3 3649.1 1127.8 1129.5 1132.8 1138.7 1140.3 1347.4 1360.3 1382.6 1393.4 1393.6 7719.2 7721.3 7742.8 7852.4 7877.8 492.8 499.6 500.7 502.7 511.3 5684.0 5808.4 6130.3 6209.2 6228.1 9118.3 9796.0 9810.8 9903.6 9922.3 9558.5 9657.0 9797.9 9816.1 9830.9 7792.7 7902.1 7902.4 7906.3 7908.4 7717.5 7758.0 7793.5 7814.0 7831.8 8717.7 8870.9 8991.6 9018.2 9114.9 9149.2 9280.5 9387.0 9400.9 9443.5 7047.8 7098.2 7321.9 7416.3 7427.0 7884.6 7920.8 7937.2 7939.9 7951.5 6450.3 7332.6 7471.7 7584.8 7589.4 7272.5 7272.8 7278.1 7402.1 7404.1 7103.9 7512.8 7528.9 7530.1 7543.2 6831.1 6865.0 6884.1 6890.4 6902.2 5997.5 6809.0 6955.6 6955.9 6959.2 10:07:55 INFO - 2015-11-19 10:07:55,370 DEBUG : BROWSER_OUTPUT: 10:07:55 INFO - 2015-11-19 10:07:55,370 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5819.65 Median:6650.44 stddev:1882.34 (28.3%) stddev-sans-first:1841.79 10:07:55 INFO - 2015-11-19 10:07:55,371 DEBUG : BROWSER_OUTPUT: Values: 319.3 319.8 328.7 330.4 333.9 6698.6 6734.1 6779.6 6779.7 6814.9 6683.5 6709.9 6710.8 6727.0 6731.0 3960.5 4952.2 4976.3 4980.7 4982.3 4715.8 4895.7 4898.9 4921.7 4923.1 4218.7 4569.1 4844.5 4850.0 4859.3 4598.7 4705.9 4728.4 4844.3 4869.6 3339.7 4009.2 4033.4 4125.5 4131.2 6326.5 6327.3 6332.0 6350.2 6387.5 5435.5 5553.6 5686.2 5695.5 5767.2 6601.3 6964.4 7023.9 7150.4 7210.3 4604.2 4616.8 4628.7 4629.4 4633.7 7477.1 7573.1 7573.3 7582.5 7583.6 4543.2 4660.0 4679.5 4689.9 4702.0 4781.6 4782.7 4783.8 4789.8 4791.5 5703.1 5708.6 5710.3 5715.6 5721.9 6978.2 7129.3 7156.4 7174.0 7181.9 1637.6 1660.0 1661.5 1661.5 1662.5 1055.0 1055.4 1060.9 1068.2 1081.8 6624.8 6646.1 6647.3 6653.6 6657.6 5961.4 7322.8 7347.7 7355.2 7358.4 6340.5 6586.7 6588.5 6592.8 6624.3 3735.2 3813.6 3880.7 3916.8 3925.5 7441.8 7488.4 7609.4 7688.5 7694.5 7614.1 7662.2 7663.3 7668.1 7668.8 7548.8 7662.0 7730.3 7752.1 7762.1 7369.4 7397.6 7401.1 7410.7 7413.7 7096.0 7320.9 7341.8 7342.7 7351.1 7687.7 7781.0 7781.1 7799.0 7804.9 4655.0 4700.5 4703.5 4707.5 4710.5 7132.3 7378.3 7380.8 7382.5 7395.6 6089.8 6863.2 7141.9 7143.5 7156.1 7130.3 7131.2 7135.8 7137.8 7138.8 6775.6 6932.7 6966.8 6982.7 6987.3 7127.9 7128.0 7131.6 7132.4 7136.6 6805.5 6980.9 6986.5 6989.8 7087.6 10:07:55 INFO - 2015-11-19 10:07:55,371 DEBUG : BROWSER_OUTPUT: 10:07:55 INFO - 2015-11-19 10:07:55,371 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18325.84 Median:27242.32 stddev:26811.41 (98.4%) stddev-sans-first:26854.04 10:07:55 INFO - 2015-11-19 10:07:55,371 DEBUG : BROWSER_OUTPUT: Values: 723.9 728.0 735.9 800.1 868.5 12444.8 14479.0 14922.9 14943.0 14952.5 11999.9 13858.4 13929.6 14027.6 14306.7 763.3 962.4 987.4 989.3 990.4 779.6 793.3 970.0 997.5 998.7 1021.3 1027.7 1037.9 1037.9 1038.3 795.1 816.3 1019.1 1027.2 1029.9 601.2 603.5 737.8 756.9 761.9 12320.4 14722.9 14731.9 14781.7 14789.1 12059.8 12180.9 12385.8 12450.1 12537.8 9399.2 9513.0 9529.2 9670.6 9827.9 3260.6 3574.9 3597.7 3606.0 3629.0 70246.2 70468.0 70635.0 72394.6 72520.5 7105.5 7578.0 9632.3 9651.3 9950.9 10866.5 12683.2 12847.4 12858.4 12903.3 6541.4 6615.0 6716.1 6796.0 6941.7 3939.9 4053.5 4054.4 4058.8 4204.8 3232.8 3265.8 3269.6 3276.0 3276.8 502.9 512.0 514.4 517.2 520.1 474.8 477.4 495.2 503.2 526.9 6771.4 8496.0 8562.1 8708.3 8792.6 432.9 541.7 545.4 631.6 633.3 3616.8 3833.5 4166.7 4229.1 4344.7 93666.0 93819.0 94518.5 96458.0 99826.0 84192.0 89151.0 89233.0 89848.0 89979.0 58659.7 66120.7 76307.0 77215.6 77769.6 8436.5 9023.9 9065.0 9131.6 9334.3 41523.0 49804.0 52467.2 53957.7 54584.0 74112.3 76219.6 77351.2 78204.6 78483.0 8054.1 8178.1 8193.4 8209.0 8251.5 12118.9 12238.8 12618.6 12676.8 13029.6 11929.7 11954.5 12049.8 12083.3 12115.6 11342.6 11369.7 11432.1 11559.7 11915.2 9696.5 11255.3 11836.4 11845.7 12285.1 9347.0 9481.1 9684.2 10079.7 10320.9 7885.2 7910.4 10023.5 10139.5 10310.3 10:07:55 INFO - 2015-11-19 10:07:55,371 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:07:55 INFO - 2015-11-19 10:07:55,371 DEBUG : BROWSER_OUTPUT: 10:07:55 INFO - 2015-11-19 10:07:55,794 INFO : Browser exited with error code: 0 10:07:55 INFO - 2015-11-19 10:07:55,819 INFO : Completed test dromaeo_css (00:18:34) 10:07:55 INFO - 2015-11-19 10:07:55,819 INFO : Starting test kraken 10:07:55 INFO - 2015-11-19 10:07:55,819 DEBUG : operating with platform_type : mac_ 10:07:55 INFO - 2015-11-19 10:07:55,819 INFO : Initialising browser for kraken test... 10:07:55 INFO - 2015-11-19 10:07:55,832 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpKqZw9B/profile http://localhost:51234/getInfo.html 10:07:57 INFO - 2015-11-19 10:07:57,852 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:07:57 INFO - 2015-11-19 10:07:57,853 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:07:57 INFO - 2015-11-19 10:07:57,853 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:07:57 INFO - 2015-11-19 10:07:57,853 DEBUG : BROWSER_OUTPUT: __metrics 10:07:57 INFO - 2015-11-19 10:07:57,870 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:07:58 INFO - 2015-11-19 10:07:58,568 INFO : Browser initialized. 10:07:58 INFO - 2015-11-19 10:07:58,568 INFO : Running cycle 1/1 for kraken test... 10:07:58 INFO - 2015-11-19 10:07:58,568 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpKqZw9B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:08:10 INFO - 2015-11-19 10:08:10,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 226177024 10:08:10 INFO - 2015-11-19 10:08:10,401 DEBUG : BROWSER_OUTPUT: 10:08:13 INFO - 2015-11-19 10:08:13,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51234/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:13 INFO - 2015-11-19 10:08:13,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 275537920 10:08:13 INFO - 2015-11-19 10:08:13,672 DEBUG : BROWSER_OUTPUT: 10:08:16 INFO - 2015-11-19 10:08:16,244 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51234/tests/kraken/driver.html?testName=audio-dft) 10:08:16 INFO - 2015-11-19 10:08:16,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 289914880 10:08:16 INFO - 2015-11-19 10:08:16,827 DEBUG : BROWSER_OUTPUT: 10:08:20 INFO - 2015-11-19 10:08:20,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51234/tests/kraken/driver.html?testName=audio-fft) 10:08:20 INFO - 2015-11-19 10:08:20,759 DEBUG : BROWSER_OUTPUT: RSS: Main: 276312064 10:08:20 INFO - 2015-11-19 10:08:20,759 DEBUG : BROWSER_OUTPUT: 10:08:22 INFO - 2015-11-19 10:08:22,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51234/tests/kraken/driver.html?testName=audio-oscillator) 10:08:23 INFO - 2015-11-19 10:08:23,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 278913024 10:08:23 INFO - 2015-11-19 10:08:23,225 DEBUG : BROWSER_OUTPUT: 10:08:25 INFO - 2015-11-19 10:08:25,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:25 INFO - 2015-11-19 10:08:25,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 279597056 10:08:25 INFO - 2015-11-19 10:08:25,934 DEBUG : BROWSER_OUTPUT: 10:08:28 INFO - 2015-11-19 10:08:28,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51234/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:29 INFO - 2015-11-19 10:08:29,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 280186880 10:08:29 INFO - 2015-11-19 10:08:29,212 DEBUG : BROWSER_OUTPUT: 10:08:31 INFO - 2015-11-19 10:08:31,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51234/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:32 INFO - 2015-11-19 10:08:32,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 279478272 10:08:32 INFO - 2015-11-19 10:08:32,575 DEBUG : BROWSER_OUTPUT: 10:08:35 INFO - 2015-11-19 10:08:35,320 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51234/tests/kraken/driver.html?testName=json-parse-financial) 10:08:35 INFO - 2015-11-19 10:08:35,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 280276992 10:08:35 INFO - 2015-11-19 10:08:35,942 DEBUG : BROWSER_OUTPUT: 10:08:37 INFO - 2015-11-19 10:08:37,456 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:38 INFO - 2015-11-19 10:08:38,033 DEBUG : BROWSER_OUTPUT: RSS: Main: 313970688 10:08:38 INFO - 2015-11-19 10:08:38,034 DEBUG : BROWSER_OUTPUT: 10:08:39 INFO - 2015-11-19 10:08:39,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51234/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:40 INFO - 2015-11-19 10:08:40,426 DEBUG : BROWSER_OUTPUT: RSS: Main: 315789312 10:08:40 INFO - 2015-11-19 10:08:40,426 DEBUG : BROWSER_OUTPUT: 10:08:42 INFO - 2015-11-19 10:08:42,450 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:43 INFO - 2015-11-19 10:08:43,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 321011712 10:08:43 INFO - 2015-11-19 10:08:43,055 DEBUG : BROWSER_OUTPUT: 10:08:45 INFO - 2015-11-19 10:08:45,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:46 INFO - 2015-11-19 10:08:46,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 322977792 10:08:46 INFO - 2015-11-19 10:08:46,218 DEBUG : BROWSER_OUTPUT: 10:08:48 INFO - 2015-11-19 10:08:48,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:49 INFO - 2015-11-19 10:08:49,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 321654784 10:08:49 INFO - 2015-11-19 10:08:49,282 DEBUG : BROWSER_OUTPUT: 10:08:50 INFO - 2015-11-19 10:08:50,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51234/tests/kraken/driver.html?testName=ai-astar) 10:08:51 INFO - 2015-11-19 10:08:51,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 381825024 10:08:51 INFO - 2015-11-19 10:08:51,196 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,196 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:08:51 INFO - 2015-11-19 10:08:51,196 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:08:51 INFO - 2015-11-19 10:08:51,196 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:08:51 INFO - 2015-11-19 10:08:51,196 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:08:51 INFO - 2015-11-19 10:08:51,196 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;109;103;110;111;110;104;161;162;110 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;146;144;153;117;140;139;117;155;114 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |2;audio-dft;187;181;184;181;184;185;187;186;257;206 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |3;audio-fft;61;75;106;75;54;58;58;67;70;54 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;82;82;118;75;75;75;113;80;112;147 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;87;86;85;86;84;85;85;86;87 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;92;93;93;93;94;94;93;93;93;94 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;87;111;85;84;85;86;87;82;78;128 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;55;56;55;54;56;56;66;54;54 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;64;65;67;68;69;68;68 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;80;81;81;80;81;83;83;82 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;129;124;121;120;128;120;110;137;126 10:08:51 INFO - 2015-11-19 10:08:51,197 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;125;138;136;137;135;125;137;137;136;136 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;66;64;67;66;65;67;66;68;66 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1119 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: __startTimestamp1447956531191__endTimestamp 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:118.80 Median:110.00 stddev:22.66 (20.6%) stddev-sans-first:23.70 10:08:51 INFO - 2015-11-19 10:08:51,198 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 103.0 110.0 111.0 110.0 104.0 161.0 162.0 110.0 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:137.70 Median:145.00 stddev:15.89 (11.0%) stddev-sans-first:15.99 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: Values: 152.0 146.0 144.0 153.0 117.0 140.0 139.0 117.0 155.0 114.0 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:193.80 Median:186.50 stddev:23.32 (12.5%) stddev-sans-first:24.60 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: Values: 187.0 181.0 184.0 181.0 184.0 185.0 187.0 186.0 257.0 206.0 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:67.80 Median:64.00 stddev:15.59 (24.4%) stddev-sans-first:16.34 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: Values: 61.0 75.0 106.0 75.0 54.0 58.0 58.0 67.0 70.0 54.0 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:95.90 Median:75.00 stddev:24.95 (33.3%) stddev-sans-first:25.95 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 118.0 75.0 75.0 75.0 113.0 80.0 112.0 147.0 10:08:51 INFO - 2015-11-19 10:08:51,199 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:1.00 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 86.0 85.0 86.0 84.0 85.0 85.0 86.0 87.0 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 93.0 93.0 94.0 94.0 93.0 93.0 93.0 94.0 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:91.30 Median:85.00 stddev:15.62 (18.4%) stddev-sans-first:16.49 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: Values: 87.0 111.0 85.0 84.0 85.0 86.0 87.0 82.0 78.0 128.0 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:3.55 (6.3%) stddev-sans-first:3.77 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: Values: 56.0 55.0 56.0 55.0 54.0 56.0 56.0 66.0 54.0 54.0 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,200 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:67.50 stddev:2.33 (3.5%) stddev-sans-first:2.22 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 64.0 65.0 67.0 68.0 69.0 68.0 68.0 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:82.00 stddev:1.08 (1.3%) stddev-sans-first:1.13 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 80.0 81.0 81.0 80.0 81.0 83.0 83.0 82.0 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:125.00 stddev:7.24 (5.8%) stddev-sans-first:7.51 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: Values: 119.0 129.0 124.0 121.0 120.0 128.0 120.0 110.0 137.0 126.0 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.20 Median:136.50 stddev:4.92 (3.6%) stddev-sans-first:3.93 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: Values: 125.0 138.0 136.0 137.0 135.0 125.0 137.0 137.0 136.0 136.0 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 10:08:51 INFO - 2015-11-19 10:08:51,201 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 64.0 67.0 66.0 65.0 67.0 66.0 68.0 66.0 10:08:51 INFO - 2015-11-19 10:08:51,202 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:08:51 INFO - 2015-11-19 10:08:51,202 DEBUG : BROWSER_OUTPUT: 10:08:51 INFO - 2015-11-19 10:08:51,849 INFO : Browser exited with error code: 0 10:08:51 INFO - 2015-11-19 10:08:51,897 INFO : Completed test kraken (00:00:56) 10:08:51 INFO - 2015-11-19 10:08:51,897 INFO : Starting test v8_7 10:08:51 INFO - 2015-11-19 10:08:51,897 DEBUG : operating with platform_type : mac_ 10:08:51 INFO - 2015-11-19 10:08:51,897 INFO : Initialising browser for v8_7 test... 10:08:51 INFO - 2015-11-19 10:08:51,915 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpE2sveD/profile http://localhost:51234/getInfo.html 10:08:54 INFO - 2015-11-19 10:08:54,121 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:08:54 INFO - 2015-11-19 10:08:54,121 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:08:54 INFO - 2015-11-19 10:08:54,121 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:08:54 INFO - 2015-11-19 10:08:54,121 DEBUG : BROWSER_OUTPUT: __metrics 10:08:54 INFO - 2015-11-19 10:08:54,137 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:08:54 INFO - 2015-11-19 10:08:54,774 INFO : Browser initialized. 10:08:54 INFO - 2015-11-19 10:08:54,775 INFO : Running cycle 1/1 for v8_7 test... 10:08:54 INFO - 2015-11-19 10:08:54,775 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpE2sveD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:09:06 INFO - 2015-11-19 10:09:06,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 226476032 10:09:06 INFO - 2015-11-19 10:09:06,695 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51234/tests/v8_7/run.html (next: http://localhost:51234/tests/v8_7/run.html) 10:09:28 INFO - 2015-11-19 10:09:28,523 DEBUG : BROWSER_OUTPUT: RSS: Main: 755539968 10:09:28 INFO - 2015-11-19 10:09:28,523 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,523 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:09:28 INFO - 2015-11-19 10:09:28,523 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:09:28 INFO - 2015-11-19 10:09:28,523 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:09:28 INFO - 2015-11-19 10:09:28,523 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:09:28 INFO - 2015-11-19 10:09:28,523 DEBUG : BROWSER_OUTPUT: |0;Richards;148.19205690574987 10:09:28 INFO - 2015-11-19 10:09:28,523 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.65535079211122 10:09:28 INFO - 2015-11-19 10:09:28,523 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.29395218002816 10:09:28 INFO - 2015-11-19 10:09:28,523 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4784.688995215311 10:09:28 INFO - 2015-11-19 10:09:28,523 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1708.1911262798635 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: |6;Boyer;13594.594594594595 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: |7;RegExp;27108.108108108107 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: |8;Splay;674.7638326585695 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4509.009009009009 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: __startTimestamp1447956568519__endTimestamp 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.19 Median:148.19 stddev:0.00 (0.0%) 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: Values: 148.2 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,524 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.66 Median:161.66 stddev:0.00 (0.0%) 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: Values: 161.7 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: Values: 281.3 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4784.69 Median:4784.69 stddev:0.00 (0.0%) 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: Values: 4784.7 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1708.19 Median:1708.19 stddev:0.00 (0.0%) 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: Values: 1708.2 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: Values: 789.9 10:09:28 INFO - 2015-11-19 10:09:28,525 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13594.59 Median:13594.59 stddev:0.00 (0.0%) 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: Values: 13594.6 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27108.11 Median:27108.11 stddev:0.00 (0.0%) 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: Values: 27108.1 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:674.76 Median:674.76 stddev:0.00 (0.0%) 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: Values: 674.8 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4509.01 Median:4509.01 stddev:0.00 (0.0%) 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: Values: 4509.0 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:09:28 INFO - 2015-11-19 10:09:28,526 DEBUG : BROWSER_OUTPUT: 10:09:29 INFO - 2015-11-19 10:09:29,174 INFO : Browser exited with error code: 0 10:09:29 INFO - 2015-11-19 10:09:29,192 INFO : Completed test v8_7 (00:00:37) 10:09:29 INFO - 2015-11-19 10:09:29,490 INFO : Completed test suite (00:20:08) 10:09:29 INFO - 2015-11-19 10:09:29,490 DEBUG : Working with test: dromaeo_css 10:09:29 INFO - 2015-11-19 10:09:29,490 DEBUG : Generating results file: dromaeo_css 10:09:29 INFO - 2015-11-19 10:09:29,491 DEBUG : Working with test: kraken 10:09:29 INFO - 2015-11-19 10:09:29,491 DEBUG : Generating results file: kraken 10:09:29 INFO - 2015-11-19 10:09:29,492 INFO : javascript benchmark 10:09:29 INFO - 2015-11-19 10:09:29,492 DEBUG : Working with test: v8_7 10:09:29 INFO - 2015-11-19 10:09:29,492 DEBUG : Generating results file: v8_7 10:09:29 INFO - 2015-11-19 10:09:29,492 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:09:29 INFO - 2015-11-19 10:09:29,917 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 10:09:29 INFO - 2015-11-19 10:09:29,917 DEBUG : process_Request line: dromaeo_css 7421.56 graph.html#tests=[[72,64,59]] 10:09:29 INFO - 2015-11-19 10:09:29,917 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:09:29 INFO - 2015-11-19 10:09:29,949 DEBUG : process_Request line: kraken 1411.30 graph.html#tests=[[232,64,59]] 10:09:29 INFO - 2015-11-19 10:09:29,949 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:09:29 INFO - 2015-11-19 10:09:29,979 DEBUG : process_Request line: v8_7 20449.77 graph.html#tests=[[230,64,59]] 10:09:29 INFO - 2015-11-19 10:09:29,980 INFO : javascript benchmark 10:09:30 INFO - 2015-11-19 10:09:29,982 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2485.242001189637, 3577.9105522361956, 3590.8922732318038, 3597.298526787274, 3614.3494171049215, 5857.970710146444, 6006.159137720711, 6084.878302433949, 6114.663693496856, 6152.784652537168, 6087.695615219232, 6099.491378240913, 6113.174721412608, 6117.694115294229, 6125.08123781433, 5395.460453954613, 5415.268938693265, 5442.074847275972, 5482.259894914176, 5525.972370138144, 4977.676451030671, 5140.563052140573, 5518.91721624176, 5520.309961254843, 5527.585431092664, 4583.266677331628, 5488.0, 5491.670499770006, 5507.256520369739, 5520.558355331564, 5473.972630136824, 5501.9174712379345, 5503.147012213113, 5522.199281104257, 5535.335759708861, 4466.374707540915, 5325.414204437548, 5334.333208348957, 5446.945530544684, 5454.481824226692, 5985.551083668699, 6039.335673075958, 6041.1240370146525, 6063.484603808682, 6066.514678825683, 6277.780277690259, 6334.1765570476, 6354.205724284465, 6359.109724638554, 6359.65021923794, 6234.844128896769, 6312.274088479838, 6326.398992095789, 6333.271673757531, 6385.936140638581, 6141.877162456771, 6166.075088736726, 6218.751249950042, 6221.0, 6225.595336303126, 6578.671066446658, 6653.334666533308, 6654.26803051664, 6658.83352916181, 6659.766908158192, 5649.887002260014, 6224.439800417984, 6230.56386052981, 6365.077063825719, 6379.681015949277, 6408.295087540367, 6413.839654008687, 6415.454686351713, 6420.550561460746, 6434.2600600930555, 6221.471174950089, 6360.204974378203, 6360.745570177233, 6372.299047104908, 6380.106785050097, 6221.782237621662, 6299.338569450233, 6343.175387199727, 6347.587406818542, 6377.649229292433, 5119.10415677255, 5119.488051194925, 5135.229715542699, 5139.820106296262, 5140.254663073833, 4580.977095114503, 4601.907961840744, 4605.953940460619, 4607.8848028798875, 4622.445306563234, 5971.820845374646, 6029.336772954972, 6047.882393421571, 6088.0, 6124.0, 6416.518761092937, 6447.967760161169, 6455.257645370749, 6477.384648458389, 6487.0269459580495, 6198.81403557894, 6202.782902598387, 6209.0996805462955, 6212.254529456494, 6219.595726277777, 5495.148252020943, 5567.164925261243, 5603.887922241533, 5604.635698679573, 5671.971640141773, 6607.0, 6664.66676666155, 6669.233038200669, 6672.065910772592, 6678.866422671422, 6391.48868090561, 6424.807255782334, 6435.324290949383, 6454.419102280817, 6456.7740129095255, 6379.425851673372, 6438.90341644885, 6444.387783160592, 6538.378854008862, 6641.833954151185, 6306.905396419149, 6327.272363678236, 6368.808935731936, 6368.936310637019, 6374.649394283359, 6302.810915672537, 6402.487800975818, 6403.807885763435, 6404.455621272244, 6412.647304398303, 5639.0, 6172.938270617236, 6337.6197428154455, 6365.649889256136, 6366.172397588284, 6210.192674952227, 6340.239171299474, 6343.0, 6353.968230159005, 6377.1390862233, 6305.148804911279, 6343.365663433619, 6348.904766428415, 6361.650109244036, 6364.427201551883, 6286.497080233662, 6328.7152078157515, 6336.20797400325, 6345.302016778059, 6359.395857393541, 6135.141080248858, 6196.47329976939, 6197.442230199304, 6366.96816515933, 6367.013112967497], "unit": "ms", "name": "dojo.html", "value": 5921.154907213501}, {"lowerIsBetter": false, "replicates": [555.111821086262, 558.290970467506, 582.2954225387281, 603.3604379357881, 631.4033238589535, 31796.68203317969, 32263.83868080659, 39064.60935390649, 40294.0, 40376.39435408471, 43236.0, 43510.564894351046, 43710.0, 43737.56262437375, 43757.56242437575, 8792.42849214799, 9761.951190244039, 9944.552495137736, 9975.50122493876, 9982.351147175446, 8753.0, 8832.249258813008, 11893.989010934081, 11940.402979850973, 11955.820662690066, 11675.299482031063, 11747.177697561174, 11751.941240293787, 11755.588554400598, 11767.411629418495, 8887.955560222157, 8994.685186018523, 11901.642950711535, 11910.34493102879, 11911.583094591691, 11846.585369512111, 11941.402929853559, 11955.64133076009, 11964.64106076819, 11969.162158648898, 40155.19689606191, 40534.594654053675, 40553.0, 40679.186416271805, 40739.7963010186, 3151.558781770554, 3286.5234540991423, 3308.520264561649, 3365.0, 3560.8753693620597, 29117.272068198254, 29444.55833162483, 29490.0, 29771.404571908657, 30338.69661303403, 2590.352411897026, 2591.157873691058, 2609.4389706213256, 2649.297936046949, 2683.6645419322585, 499311.0, 503152.0, 504238.47880760726, 504779.0, 504973.0, 59580.70209649011, 60663.0, 60962.695186523786, 65386.0, 66951.99572006424, 63482.0, 64079.679601601696, 64385.35614643887, 64401.0, 64508.0, 15915.363385464452, 16050.438234661731, 16070.839291607168, 16072.357105715875, 16081.839181608035, 12701.174423662433, 12752.617421477371, 12764.234145951086, 12885.549005784753, 12887.420066097047, 20169.294074707315, 20350.18599256043, 20386.796132038788, 20396.0, 20441.897790510953, 8465.66137354499, 8564.571771411405, 8571.228589426857, 8626.741197764077, 8729.08344623818, 875.146731936357, 929.7582628516634, 1076.8923107689325, 1086.9728256793485, 1138.231693606812, 29420.411591768472, 29432.55851162234, 29762.404751905273, 30123.096307110824, 30233.09300720938, 1046.2467023742893, 1047.0314958663207, 1081.2485322700804, 1109.8279766636185, 1165.3998190931677, 12478.563250286197, 14517.0, 14539.3457294422, 15429.691406172038, 15488.0, 473541.0, 480101.0, 480218.0, 480325.0, 482337.5883120562, 50725.23912141321, 51312.74343628332, 58131.128033079534, 58310.0, 61882.0, 1492.962675933067, 1494.1632685696045, 1497.1915165810558, 1508.5172744721583, 1531.9888873343762, 30677.23306917345, 30739.846300768353, 30759.0, 31489.685103148677, 31544.36911261716, 46767.0, 47484.812879678284, 51888.702782430744, 53336.73331633317, 53378.19932700935, 396116.0388396079, 449104.0, 450608.0, 451117.0, 451633.0, 26551.867240663672, 33103.855133762256, 33347.66652333543, 33487.82792602247, 33491.83254083714, 42403.1519369617, 43060.35409468798, 43085.56914430815, 43104.0, 43418.0, 37052.268042780255, 37461.0, 37902.8104859474, 38255.617443825206, 38257.6174238254, 36366.0, 36888.12836346566, 37343.6265637351, 37534.8123259382, 37584.43623345707, 36087.44383499134, 36807.07982300464, 36976.890693279245, 37188.81405592955, 37333.81333093317, 32167.678323217406, 33513.83243083769, 34930.65069349274, 35539.82230088936, 35906.10234744152, 24412.63381049321, 24753.0, 24763.752362476866, 25430.109946151795, 32698.0], "unit": "ms", "name": "ext.html", "value": 20194.208257246635}, {"lowerIsBetter": false, "replicates": [309.7212508742132, 360.70962874885726, 364.56252497003595, 364.8175912043978, 364.8248840556533, 12654.810177847317, 16633.83366166338, 19777.30779422719, 20460.69308960365, 21347.893260533674, 20694.275700350492, 20763.065662045206, 21161.68257476135, 21164.730116193, 21185.57628847422, 5972.581919265654, 6166.0, 6167.074938759177, 6173.043178307369, 6175.197224360849, 4420.447444069491, 4546.499885012646, 4563.566461186182, 6072.180255665473, 6643.269240383554, 5692.402297758737, 6589.868202635945, 6755.8311042224095, 6775.424088952445, 6788.830279243034, 6733.730650773963, 6772.966135169293, 6779.7966061018005, 6780.694868730919, 6782.253952065269, 5776.162456443834, 5905.438983296623, 5912.911306330366, 5936.376680448534, 5939.168516407706, 26155.215343539534, 26373.68131593432, 27136.32159196016, 27177.86411067952, 27791.305217369525, 2089.268755935426, 2094.937151885446, 2400.5558971590135, 2658.787297016234, 2705.0397109026408, 15061.548153555412, 15377.154256515887, 15624.140672263022, 15640.921795391065, 15845.038919209086, 1328.9136206146666, 1681.0166052859092, 1739.2173521915063, 1762.4536393717988, 1783.7591925090076, 103154.0, 105283.0, 105502.99999999923, 106993.46503267511, 108210.91789082087, 11669.0, 11959.880401196051, 11959.940200299117, 11979.580714674945, 12060.75878482443, 14349.852011839028, 14444.0, 14467.27663616836, 14475.203863787592, 14499.637509062148, 9048.819023619491, 9083.18251357381, 9088.0, 9093.31800114994, 9158.221551168092, 7349.63251837406, 9084.500352480676, 9104.362694611315, 9204.63181472747, 9205.493697846683, 6669.233038200669, 6705.027770973182, 6706.094677218611, 6719.932800671931, 6731.663416829139, 1696.8291878603725, 1742.392387899629, 1787.6156626325403, 1873.4660621722744, 1940.706695189916, 424.3359142941287, 430.341577386599, 446.23025281389346, 461.15608436561683, 485.60908468682345, 11021.504032318566, 12371.628851134481, 12486.562970295996, 12581.937090314674, 12812.487500499876, 426.3051226500784, 462.87502374358735, 469.6594968647703, 491.6214514823566, 505.8887044850127, 6126.172966649535, 6625.469962402996, 6691.297413771581, 6696.296888826603, 6708.295628958889, 760363.0, 762728.0, 764626.0, 778193.0, 781528.0, 110184.0, 114544.42727786474, 116947.0, 118222.0, 122468.77531224753, 511.5702809639846, 528.0468753899248, 529.5498825997871, 529.7721979548832, 530.2020459208943, 11753.059755219732, 11797.17419780607, 11957.940210298893, 11967.700807479534, 11973.640790776291, 34911.825440872635, 37807.62192378041, 47263.05473890434, 48855.51144488652, 48862.23267304539, 65882.0, 67638.66180669065, 72231.0, 72924.0, 73077.53844923178, 6287.245530536182, 6522.934770652233, 6525.119108920235, 6529.934700652932, 6533.346665333429, 12237.571684990982, 12478.625641230778, 12567.87432125667, 12598.0, 12611.621651350475, 10803.0, 11042.006219440289, 11072.667819965414, 11114.44427778624, 11145.0, 10539.473026348498, 10753.946230269112, 10875.07561857251, 10904.727381815517, 11081.27971681838, 9456.763580910532, 9716.951415242878, 9724.562394692115, 9751.902480975383, 10885.455727213766, 6377.713002914973, 6489.702059588196, 6539.771108011387, 6546.967265163644, 6571.277159512354, 10957.945210273898, 11069.169812263952, 11235.775284494428, 11270.042046426146, 11377.772444550897], "unit": "ms", "name": "jquery.html", "value": 8705.495679665539}, {"lowerIsBetter": false, "replicates": [1546.845315468454, 1547.473858887978, 1656.5196093132993, 1872.9698665733847, 1874.5126267170535, 7304.488685791996, 7610.277023682748, 8091.474054186481, 8333.041700204478, 8340.83318333633, 8120.715774947863, 8194.385421093411, 8241.670333186681, 8244.83510329793, 8272.338212942965, 2360.2683168217823, 2384.2608791274674, 2387.1167667962877, 2387.928362149138, 2389.2115601851347, 2360.9645855312183, 2377.8454400464, 2401.8438801477937, 2402.8318017738766, 2414.95170096598, 2331.6968794056747, 2354.0466111224982, 2358.5400846834787, 2362.303120579433, 2368.0882860098814, 2329.6389059695775, 2356.8350215484925, 2366.8343215974974, 2368.3842201027683, 2368.4789346343778, 2373.2049763329305, 2393.4136136646634, 2399.3881560202212, 2406.446517301013, 2406.6871306730186, 7232.855342893113, 8244.670213191464, 8276.83446331076, 8282.461639993442, 8285.25432711059, 4463.419755431773, 4544.931826022612, 4990.426100998359, 5099.796008159669, 5110.105731496973, 2973.925651858699, 3520.5775306963073, 3576.7317451191007, 3599.406097993828, 3600.945985810215, 964.9372790768648, 1021.687132035331, 1038.4485061091086, 1060.8461773042943, 1089.4171618184234, 10867.184961127947, 10925.672229833117, 10948.507317170746, 10953.0, 10964.780704385868, 4527.230370836965, 4637.8840528986375, 4711.693739906895, 4779.498152693986, 4781.497942716034, 8903.465792052497, 9021.233195178353, 9036.45781253127, 9045.231155351737, 9064.365494415459, 5091.516305950929, 5093.363329583802, 5106.974465127651, 5116.820911268088, 5122.257272695439, 4662.7668616569035, 4735.881602959954, 4736.905261894743, 4743.928841067387, 4753.738544380023, 3450.741194410429, 3608.476770868262, 3612.2414292998237, 3637.308911306843, 3649.069487280726, 1127.7969965406141, 1129.48043899807, 1132.7791080739178, 1138.6527109231763, 1140.2531341971023, 1347.4206091380604, 1360.3130419138272, 1382.5852244326863, 1393.4217299820664, 1393.6306878677158, 7719.150893401721, 7721.343685786659, 7742.806429839299, 7852.371810255166, 7877.842443151105, 492.83736366998806, 499.60780787081967, 500.6770632941805, 502.7260143221953, 511.2510172597163, 5684.0, 5808.419158084243, 6130.295016073209, 6209.223847019122, 6228.096925945712, 9118.270538356915, 9795.951020244996, 9810.803783924424, 9903.554340054714, 9922.255830812717, 9558.474283914313, 9657.0, 9797.853032204523, 9816.116549510578, 9830.852537211947, 7792.727254546177, 7902.051753789582, 7902.407319450949, 7906.327962123284, 7908.406869484812, 7717.459777815724, 7758.030246219223, 7793.493422927719, 7814.0, 7831.804204894923, 8717.65129394817, 8870.866936996079, 8991.55042247898, 9018.23345015681, 9114.908850911672, 9149.222316103205, 9280.535973201448, 9387.014363491735, 9400.858987115336, 9443.527823608929, 7047.788566343018, 7098.183708873546, 7321.853562928605, 7416.332530072319, 7427.0, 7884.605769711607, 7920.84158316842, 7937.2459616336355, 7939.920600793918, 7951.483153594998, 6450.258430223907, 7332.560046397233, 7471.701131954661, 7584.810379740551, 7589.43079269046, 7272.454565907684, 7272.781816545512, 7278.126624805057, 7402.1117465904435, 7404.148522919933, 7103.893441598483, 7512.774616761506, 7528.887066693895, 7530.134034585873, 7543.170251272246, 6831.11195544576, 6864.965675171592, 6884.139482564679, 6890.414314783099, 6902.171739391104, 5997.460228579449, 6809.012693159563, 6955.582665040114, 6955.930440695731, 6959.234484206632], "unit": "ms", "name": "mootools.html", "value": 4625.571781267296}, {"lowerIsBetter": false, "replicates": [319.3007313982379, 319.8464736926275, 328.70252421558484, 330.39042965728254, 333.8914852672883, 6698.564593301432, 6734.057231987519, 6779.62712050837, 6779.694913728882, 6814.931850681492, 6683.465322774178, 6709.926411774117, 6710.825605519039, 6727.0, 6730.96634516828, 3960.544537378202, 4952.232403977389, 4976.278439626252, 4980.6762560433635, 4982.277569752384, 4715.834945776881, 4895.657303988723, 4898.902021959559, 4921.704697718131, 4923.089228492722, 4218.713292445803, 4569.13186494565, 4844.491328410501, 4849.951500485003, 4859.343988561534, 4598.655100867415, 4705.858824235278, 4728.432588089417, 4844.297576851354, 4869.610431165498, 3339.682730140657, 4009.1781184857327, 4033.3748269018347, 4125.546189919107, 4131.194417088669, 6326.5255105867245, 6327.335629758901, 6331.968340158316, 6350.206224221973, 6387.498937749625, 5435.510804027617, 5553.611247212697, 5686.232358631573, 5695.5443564514735, 5767.1637612546365, 6601.3068627794355, 6964.4428445724225, 7023.89464158038, 7150.356467917913, 7210.2789721028, 4604.240300350438, 4616.838410655611, 4628.722276663411, 4629.421322334708, 4633.698809577367, 7477.140128885139, 7573.053368328904, 7573.318401343906, 7582.469227154046, 7583.62081895903, 4543.227651299287, 4660.0, 4679.549339704702, 4689.929651055237, 4701.95298047022, 4781.617470602343, 4782.689125206851, 4783.808647654055, 4789.808407663724, 4791.520847915181, 5703.144528320702, 5708.628939118944, 5710.343310519261, 5715.599908006483, 5721.856953576111, 6978.197507286727, 7129.322714342129, 7156.427485801123, 7173.964130179315, 7181.856362872818, 1637.5742307000028, 1659.96680066398, 1661.534770264328, 1661.534770264328, 1662.534490342706, 1055.0, 1055.3562326980536, 1060.9151267898549, 1068.2255364860569, 1081.751197224627, 6624.7681331154145, 6646.069550262967, 6647.268800431949, 6653.604702307165, 6657.633830139389, 5961.403859614091, 7322.816929576803, 7347.669354879044, 7355.1541572719825, 7358.374538164209, 6340.492760579143, 6586.670666466657, 6588.4729221662155, 6592.76925307612, 6624.27133015368, 3735.159589092487, 3813.637704418076, 3880.708946828999, 3916.804159791999, 3925.450436938831, 7441.8139546511775, 7488.4009279257525, 7609.429292803062, 7688.461807673521, 7694.499857509244, 7614.124375696755, 7662.195469475736, 7663.348615367756, 7668.118166410823, 7668.769936901902, 7548.8490230196185, 7661.961690191513, 7730.265624765526, 7752.14726380109, 7762.107357653942, 7369.410447164321, 7397.630118494161, 7401.0748656417945, 7410.740624078131, 7413.666385012795, 7096.042034325506, 7320.9267907320245, 7341.816454588678, 7342.743003994835, 7351.117865856131, 7687.692492300245, 7780.961095194488, 7781.144074151725, 7798.961005194938, 7804.9219507806465, 4655.0, 4700.529947005409, 4703.506131856243, 4707.529247075265, 4710.479893257091, 7132.322429369202, 7378.335949764547, 7380.815479612837, 7382.483226174117, 7395.593242371721, 6089.842929843316, 6863.245043045161, 7141.857162856818, 7143.535670181422, 7156.141263048467, 7130.251323611154, 7131.179914309921, 7135.751243532257, 7137.82155446118, 7138.8215294615975, 6775.559588626724, 6932.746857271508, 6966.756163534252, 6982.685779140053, 6987.301269872972, 7127.8574428512175, 7128.0, 7131.572105673468, 7132.393746531603, 7136.643167841691, 6805.455563555002, 6980.930190698028, 6986.510944233854, 6989.825254368681, 7087.574745515286], "unit": "ms", "name": "prototype.html", "value": 5185.830618352429}, {"lowerIsBetter": false, "replicates": [723.8841785314344, 728.0317178153053, 735.9374453171481, 800.0759123212691, 868.4789126524084, 12444.751104977917, 14479.0, 14922.850771492282, 14943.028703134289, 14952.476663316786, 11999.940000300008, 13858.4456621735, 13929.582112536615, 14027.579172624837, 14306.713865722679, 763.3282711214124, 962.41292811385, 987.3582171588489, 989.3074847606669, 990.400807511456, 779.6452614060589, 793.2543409195338, 970.0348153587155, 997.5211898288826, 998.7053819123377, 1021.2646894236138, 1027.6916924922493, 1037.9117774989097, 1037.9117774989136, 1038.2939601071268, 795.1372760554805, 816.2531283875247, 1019.0624625344701, 1027.2193133218732, 1029.9485025748684, 601.2004034633926, 603.471962033221, 737.819234287603, 756.916739158692, 761.9466637335389, 12320.445579948924, 14722.852771472255, 14731.926340368336, 14781.704365912728, 14789.11265324084, 12059.819102713467, 12180.878191218064, 12385.814212786816, 12450.128491005633, 12537.811932821014, 9399.201067909236, 9512.95243523778, 9529.190018848407, 9670.613175472972, 9827.90172098277, 3260.6250281217726, 3574.874879379235, 3597.6941959933174, 3606.0, 3629.0201645555553, 70246.2438439038, 70468.0, 70635.0, 72394.63802680952, 72520.54958900792, 7105.502614816914, 7578.0, 9632.325737198329, 9651.324407291422, 9950.850737238947, 10866.45667716611, 12683.23900565969, 12847.421866016051, 12858.421371038326, 12903.290319032543, 6541.411272985454, 6614.98243035869, 6716.059751634775, 6796.0, 6941.7223311068, 3939.9212015759526, 4053.4527838741983, 4054.351303791379, 4058.837646494107, 4204.768737719393, 3232.8383580820864, 3265.804051756902, 3269.5613929871256, 3276.0335700967794, 3276.7542434317043, 502.8516587606665, 511.9939319237716, 514.4495389932811, 517.1647788821027, 520.0794593569361, 474.8371169323763, 477.36748807829764, 495.2398068964123, 503.2250334484925, 526.9077911365496, 6771.424428923498, 8495.957520212483, 8562.100979397073, 8708.259797917248, 8792.558618708412, 432.90908909129433, 541.7264281537877, 545.4082320682104, 631.5515983651567, 633.2654121219364, 3616.8191590420374, 3833.501644786216, 4166.6666666666715, 4229.111886503807, 4344.739315641008, 93666.0, 93819.0, 94518.52740736252, 96458.0, 99826.0, 84192.0, 89151.0, 89233.0, 89848.0, 89979.0, 58659.70670146622, 66120.66939665271, 76307.0, 77215.61392193002, 77769.61115194387, 8436.53599052058, 9023.909760902307, 9065.02891611833, 9131.634734610807, 9334.25325973934, 41522.99999999879, 49804.00391992212, 52467.21299180439, 53957.730211348695, 54584.0, 74112.25887741054, 76219.61890190735, 77351.2264877344, 78204.60897695702, 78483.0, 8054.114047454893, 8178.059523154913, 8193.385496087936, 8209.0, 8251.504909705436, 12118.878811211775, 12238.75522489563, 12618.621441356774, 12676.809847852106, 13029.609111726664, 11929.701757456132, 11954.462049207981, 12049.81925271104, 12083.275003499819, 12115.636530904087, 11342.60300889465, 11369.715757105807, 11432.142589306002, 11559.711007224887, 11915.16593838423, 9696.515174241118, 11255.324680519196, 11836.408179591159, 11845.703857403634, 12285.140040197459, 9347.0, 9481.141904563374, 9684.225261979165, 10079.748006299902, 10320.896791032294, 7885.2114788520685, 7910.406719495946, 10023.46232663118, 10139.543720532447, 10310.32982856112], "unit": "ms", "name": "yui.html", "value": 6691.538405860554}], "name": "dromaeo_css", "value": 7421.564071535074}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 109.0, 103.0, 110.0, 111.0, 110.0, 104.0, 161.0, 162.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 118.8}, {"lowerIsBetter": true, "replicates": [152.0, 146.0, 144.0, 153.0, 117.0, 140.0, 139.0, 117.0, 155.0, 114.0], "unit": "ms", "name": "audio-beat-detection", "value": 137.7}, {"lowerIsBetter": true, "replicates": [187.0, 181.0, 184.0, 181.0, 184.0, 185.0, 187.0, 186.0, 257.0, 206.0], "unit": "ms", "name": "audio-dft", "value": 193.8}, {"lowerIsBetter": true, "replicates": [61.0, 75.0, 106.0, 75.0, 54.0, 58.0, 58.0, 67.0, 70.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 67.8}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 118.0, 75.0, 75.0, 75.0, 113.0, 80.0, 112.0, 147.0], "unit": "ms", "name": "audio-oscillator", "value": 95.9}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 86.0, 85.0, 86.0, 84.0, 85.0, 85.0, 86.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 85.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.2}, {"lowerIsBetter": true, "replicates": [87.0, 111.0, 85.0, 84.0, 85.0, 86.0, 87.0, 82.0, 78.0, 128.0], "unit": "ms", "name": "imaging-desaturate", "value": 91.3}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 55.0, 54.0, 56.0, 56.0, 66.0, 54.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 56.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 64.0, 65.0, 67.0, 68.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.9}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 80.0, 81.0, 81.0, 80.0, 81.0, 83.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.5}, {"lowerIsBetter": true, "replicates": [119.0, 129.0, 124.0, 121.0, 120.0, 128.0, 120.0, 110.0, 137.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [125.0, 138.0, 136.0, 137.0, 135.0, 125.0, 137.0, 137.0, 136.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 134.2}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 64.0, 67.0, 66.0, 65.0, 67.0, 66.0, 68.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1411.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.19205690574987], "unit": "score", "name": "Richards", "value": 238.21789600000002}, {"lowerIsBetter": false, "replicates": [161.65535079211122], "unit": "score", "name": "DeltaBlue", "value": 409.00594800000005}, {"lowerIsBetter": false, "replicates": [281.29395218002816], "unit": "score", "name": "Encrypt", "value": 946.2734550000002}, {"lowerIsBetter": false, "replicates": [4784.688995215311], "unit": "score", "name": "Decrypt", "value": 55.63182899999996}, {"lowerIsBetter": false, "replicates": [1708.1911262798635], "unit": "score", "name": "RayTrace", "value": 433.2003536463537}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [13594.594594594595], "unit": "score", "name": "Boyer", "value": 49.02411729622268}, {"lowerIsBetter": false, "replicates": [27108.108108108107], "unit": "score", "name": "RegExp", "value": 33.60562811565303}, {"lowerIsBetter": false, "replicates": [674.7638326585695], "unit": "score", "name": "Splay", "value": 120.76966199999997}, {"lowerIsBetter": false, "replicates": [4509.009009009009], "unit": "score", "name": "NavierStokes", "value": 329.11888111888123}], "name": "v8_7", "value": 20449.770478823983}]} 10:09:30 INFO - RETURN: dromaeo_css: 7421.56 10:09:30 INFO - RETURN: kraken: 1411.30 10:09:30 INFO - RETURN: v8_7: 20449.77 10:09:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20449.77"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1411.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7421.56"}}} 10:09:30 INFO - Return code: 0 10:09:30 INFO - # TBPL SUCCESS # 10:09:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:30 INFO - 2015-11-19 10:09:30.084 screenresolution[1988:18610] starting screenresolution argv=screenresolution get 10:09:30 INFO - 2015-11-19 10:09:30.087 screenresolution[1988:18610] Display 0: 1600x1200x32@60 10:09:30 INFO - 2015-11-19 10:09:30.092 screenresolution[1989:18613] starting screenresolution argv=screenresolution list 10:09:30 INFO - Available Modes on Display 0 10:09:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:30 INFO - Intel Iris: 10:09:30 INFO - Chipset Model: Intel Iris 10:09:30 INFO - Type: GPU 10:09:30 INFO - Bus: Built-In 10:09:30 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:30 INFO - Vendor: Intel (0x8086) 10:09:30 INFO - Device ID: 0x0a2e 10:09:30 INFO - Revision ID: 0x0009 10:09:30 INFO - Displays: 10:09:30 INFO - Display: 10:09:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:30 INFO - Display Serial Number: 1600x1200 60 10:09:30 INFO - Main Display: Yes 10:09:30 INFO - Mirror: Off 10:09:30 INFO - Online: Yes 10:09:30 INFO - Rotation: Supported 10:09:30 INFO - Return code: 0 10:09:30 INFO - Running post-action listener: _resource_record_post_action 10:09:30 INFO - Running post-run listener: _resource_record_post_run 10:09:31 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 2797568; Write bytes: 689350656; Read time: 55; Write time: 1974 10:09:31 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 338391552; Write bytes: 338142720; Read time: 25956; Write time: 595 10:09:31 INFO - run-tests - Wall time: 1210s; CPU: 53.0%; Read bytes: 2781184; Write bytes: 339915264; Read time: 50; Write time: 1343 10:09:31 INFO - Running post-run listener: _upload_blobber_files 10:09:31 INFO - Blob upload gear active. 10:09:31 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:09:31 INFO - Copying logs to upload dir... 10:09:31 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.372233 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-11-19 10:09:31.443010) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 10:09:31.446700) ========= 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.v4I2osg3Rk/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.sKEY6ob42C/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009342 build_url: 'https://queue.taskcluster.net/v1/task/bYtqdojLRyi-tlgsWVarUA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 10:09:31.469550) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:09:31.469885) ========= 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.v4I2osg3Rk/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.sKEY6ob42C/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004963 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 10:09:31.518071) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 10:09:31.518529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 10:09:31.518906) ========= ========= Total master_lag: 0.21 =========