builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0033 starttime: 1446704844.46 results: success (0) buildid: 20151104204536 builduid: 441222c3860d4c4a8e1eb02a5e8b6d40 revision: eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:24.463966) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:24.464343) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:24.464819) ========= 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.4whKtRhu4K/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.enrs6DKQA6/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006509 basedir: '/builds/slave/test' ========= master_lag: 0.34 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:24.808159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:24.808476) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:24.850645) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:24.850984) ========= 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.4whKtRhu4K/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.enrs6DKQA6/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.029513 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:24.904236) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:24.904556) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:24.904888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:24.905155) ========= 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.4whKtRhu4K/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.enrs6DKQA6/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-04 22:27:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25, 63.245.215.25, ... Connecting to hg.mozilla.org|63.245.215.102|: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.13G=0s 2015-11-04 22:27:25 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:25.121501) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:25.121785) ========= 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.4whKtRhu4K/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.enrs6DKQA6/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.123617 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:25.261431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:25.261755) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c --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 eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4whKtRhu4K/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.enrs6DKQA6/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-04 22:27:25,359 truncating revision to first 12 chars 2015-11-04 22:27:25,359 Setting DEBUG logging. 2015-11-04 22:27:25,359 attempt 1/10 2015-11-04 22:27:25,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb607c348695?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-04 22:27:25,629 unpacking tar archive at: fx-team-eb607c348695/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583915 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:25.947744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:25.948073) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:25.992310) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:25.992631) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-04 22:27:25.993142) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 29 secs) (at 2015-11-04 22:27:25.993421) ========= /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.4whKtRhu4K/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.enrs6DKQA6/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 22:27:26 INFO - MultiFileLogger online at 20151104 22:27:26 in /builds/slave/test 22:27:26 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 22:27:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:27:26 INFO - {'append_to_log': False, 22:27:26 INFO - 'base_work_dir': '/builds/slave/test', 22:27:26 INFO - 'blob_upload_branch': 'Fx-Team', 22:27:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:27:26 INFO - 'branch': 'Fx-Team', 22:27:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:27:26 INFO - 'config_files': ('talos/mac_config.py',), 22:27:26 INFO - 'default_actions': ('clobber', 22:27:26 INFO - 'read-buildbot-config', 22:27:26 INFO - 'download-and-extract', 22:27:26 INFO - 'populate-webroot', 22:27:26 INFO - 'create-virtualenv', 22:27:26 INFO - 'install', 22:27:26 INFO - 'run-tests'), 22:27:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:27:26 INFO - 'download_minidump_stackwalk': True, 22:27:26 INFO - 'download_symbols': 'ondemand', 22:27:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:27:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:27:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:27:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:27:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:27:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:27:26 INFO - 'installer_path': 'installer.exe', 22:27:26 INFO - 'log_level': 'info', 22:27:26 INFO - 'log_name': 'talos', 22:27:26 INFO - 'log_to_console': True, 22:27:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:27:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:27:26 INFO - 'opt_config_files': (), 22:27:26 INFO - 'pip_index': False, 22:27:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:27:26 INFO - 'cmd': ('bash', 22:27:26 INFO - '-c', 22:27:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:27:26 INFO - 'enabled': True, 22:27:26 INFO - 'halt_on_failure': False, 22:27:26 INFO - 'name': 'check_screen_resolution'},), 22:27:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:27:26 INFO - 'cmd': ('bash', 22:27:26 INFO - '-c', 22:27:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:27:26 INFO - 'enabled': True, 22:27:26 INFO - 'halt_on_failure': False, 22:27:26 INFO - 'name': 'check_screen_resolution'},), 22:27:26 INFO - 'run_cmd_checks_enabled': True, 22:27:26 INFO - 'sps_profile': False, 22:27:26 INFO - 'sps_profile_interval': 0, 22:27:26 INFO - 'suite': 'dromaeojs', 22:27:26 INFO - 'system_bits': '64', 22:27:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:27:26 INFO - 'title': 't-yosemite-r5-0033', 22:27:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:27:26 INFO - 'use_talos_json': True, 22:27:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:27:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:27:26 INFO - 'work_dir': 'build'} 22:27:26 INFO - ##### 22:27:26 INFO - ##### Running clobber step. 22:27:26 INFO - ##### 22:27:26 INFO - Running pre-action listener: _resource_record_pre_action 22:27:26 INFO - Running main action method: clobber 22:27:26 INFO - rmtree: /builds/slave/test/build 22:27:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:27:32 INFO - Running post-action listener: _resource_record_post_action 22:27:32 INFO - ##### 22:27:32 INFO - ##### Running read-buildbot-config step. 22:27:32 INFO - ##### 22:27:32 INFO - Running pre-action listener: _resource_record_pre_action 22:27:32 INFO - Running main action method: read_buildbot_config 22:27:32 INFO - Using buildbot properties: 22:27:32 INFO - { 22:27:32 INFO - "properties": { 22:27:32 INFO - "buildnumber": 1187, 22:27:32 INFO - "product": "firefox", 22:27:32 INFO - "script_repo_revision": "production", 22:27:32 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 22:27:32 INFO - "repository": "", 22:27:32 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 22:27:32 INFO - "buildid": "20151104204536", 22:27:32 INFO - "slavename": "t-yosemite-r5-0033", 22:27:32 INFO - "pgo_build": "False", 22:27:32 INFO - "basedir": "/builds/slave/test", 22:27:32 INFO - "project": "", 22:27:32 INFO - "platform": "yosemite", 22:27:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 22:27:32 INFO - "slavebuilddir": "test", 22:27:32 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:27:32 INFO - "branch": "fx-team", 22:27:32 INFO - "repo_path": "integration/fx-team", 22:27:32 INFO - "stage_platform": "macosx64", 22:27:32 INFO - "builduid": "441222c3860d4c4a8e1eb02a5e8b6d40", 22:27:32 INFO - "revision": "eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c" 22:27:32 INFO - }, 22:27:32 INFO - "sourcestamp": { 22:27:32 INFO - "repository": "", 22:27:32 INFO - "hasPatch": false, 22:27:32 INFO - "project": "", 22:27:32 INFO - "branch": "fx-team-macosx64-talos", 22:27:32 INFO - "changes": [ 22:27:32 INFO - { 22:27:32 INFO - "category": null, 22:27:32 INFO - "files": [ 22:27:32 INFO - { 22:27:32 INFO - "url": null, 22:27:32 INFO - "name": "https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 22:27:32 INFO - } 22:27:32 INFO - ], 22:27:32 INFO - "repository": "", 22:27:32 INFO - "rev": "eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c", 22:27:32 INFO - "who": "jryans@gmail.com", 22:27:32 INFO - "when": 1446704835, 22:27:32 INFO - "number": 6623284, 22:27:32 INFO - "comments": "Bug 1182722 - Fix l10n-check on Windows. r=me on a CLOSED TREE\n", 22:27:32 INFO - "project": "", 22:27:32 INFO - "at": "Wed 04 Nov 2015 22:27:15", 22:27:32 INFO - "branch": "fx-team-macosx64-talos", 22:27:32 INFO - "revlink": "", 22:27:32 INFO - "properties": [ 22:27:32 INFO - [ 22:27:32 INFO - "buildid", 22:27:32 INFO - "20151104204536", 22:27:32 INFO - "Change" 22:27:32 INFO - ], 22:27:32 INFO - [ 22:27:32 INFO - "builduid", 22:27:32 INFO - "441222c3860d4c4a8e1eb02a5e8b6d40", 22:27:32 INFO - "Change" 22:27:32 INFO - ], 22:27:32 INFO - [ 22:27:32 INFO - "pgo_build", 22:27:32 INFO - "False", 22:27:32 INFO - "Change" 22:27:32 INFO - ] 22:27:32 INFO - ], 22:27:32 INFO - "revision": "eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c" 22:27:32 INFO - } 22:27:32 INFO - ], 22:27:32 INFO - "revision": "eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c" 22:27:32 INFO - } 22:27:32 INFO - } 22:27:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 22:27:32 INFO - Running post-action listener: _resource_record_post_action 22:27:32 INFO - ##### 22:27:32 INFO - ##### Running download-and-extract step. 22:27:32 INFO - ##### 22:27:32 INFO - Running pre-action listener: _resource_record_pre_action 22:27:32 INFO - Running main action method: download_and_extract 22:27:32 INFO - mkdir: /builds/slave/test/build/tests 22:27:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:32 INFO - https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:27:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/test_packages.json 22:27:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/test_packages.json 22:27:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:27:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:27:48 INFO - Downloaded 1149 bytes. 22:27:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:27:48 INFO - Using the following test package requirements: 22:27:48 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:27:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:48 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 22:27:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:48 INFO - u'jsshell-mac.zip'], 22:27:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:48 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 22:27:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:27:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:48 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 22:27:48 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:48 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 22:27:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:48 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 22:27:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:27:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:48 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 22:27:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:48 INFO - https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:27:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:27:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:27:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/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 22:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/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 22:27:54 INFO - Downloaded 17457297 bytes. 22:27:54 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 22:27:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:27:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:28:00 INFO - Return code: 0 22:28:00 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 22:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:00 INFO - https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:28:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:28:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:28:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/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 22:28:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/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 22:28:01 INFO - Downloaded 17457297 bytes. 22:28:01 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 22:28:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:28:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:28:07 INFO - Return code: 0 22:28:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:07 INFO - https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:28:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:28:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:28:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/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 22:28:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/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 22:28:08 INFO - Downloaded 11131307 bytes. 22:28:08 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 22:28:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:28:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 22:28:08 INFO - Return code: 0 22:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:08 INFO - https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:28:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:28:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:28:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 22:28:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/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 22:28:13 INFO - Downloaded 108652750 bytes. 22:28:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:28:13 INFO - mkdir: /builds/slave/test/properties 22:28:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:28:13 INFO - Writing to file /builds/slave/test/properties/build_url 22:28:13 INFO - Contents: 22:28:13 INFO - build_url:https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:28:13 INFO - Running post-action listener: _resource_record_post_action 22:28:13 INFO - Running post-action listener: set_extra_try_arguments 22:28:13 INFO - ##### 22:28:13 INFO - ##### Running populate-webroot step. 22:28:13 INFO - ##### 22:28:13 INFO - Running pre-action listener: _resource_record_pre_action 22:28:13 INFO - Running main action method: populate_webroot 22:28:13 INFO - Guessing talos json url... 22:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:13 INFO - https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt matches https://queue.taskcluster.net 22:28:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 22:28:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt 22:28:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt to /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 22:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.txt', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.txt'}, attempt #1 22:28:13 INFO - Downloaded 103 bytes. 22:28:13 INFO - Reading from file /builds/slave/test/build/firefox-45.0a1.en-US.mac.txt 22:28:13 INFO - Contents: 22:28:13 INFO - 20151104204536 22:28:13 INFO - https://hg.mozilla.org/integration/fx-team/rev/eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c 22:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:13 INFO - trying https://hg.mozilla.org/integration/fx-team/raw-file/eb607c3486/testing/talos/talos.json 22:28:13 INFO - Downloading https://hg.mozilla.org/integration/fx-team/raw-file/eb607c3486/testing/talos/talos.json to /builds/slave/test/build/talos.json 22:28:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://hg.mozilla.org/integration/fx-team/raw-file/eb607c3486/testing/talos/talos.json', 'file_name': '/builds/slave/test/build/talos.json'}, attempt #1 22:28:14 INFO - Downloaded 4264 bytes. 22:28:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:28:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:28:14 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:28:14 INFO - '../fennec_ids.txt'], 22:28:14 INFO - 'tests': ['tcheck2']}, 22:28:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:28:14 INFO - '--tppagecycles', 22:28:14 INFO - '7'], 22:28:14 INFO - 'tests': ['tsvgm']}}, 22:28:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:28:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:28:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:28:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:28:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:28:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:28:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:28:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:14 INFO - 'talos_options': ['--e10s'], 22:28:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:28:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:14 INFO - 'tests': ['damp', 'tps']}, 22:28:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:14 INFO - 'talos_options': ['--e10s'], 22:28:14 INFO - 'tests': ['damp', 'tps']}, 22:28:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:28:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:28:14 INFO - 'other': {'tests': ['a11yr', 22:28:14 INFO - 'ts_paint', 22:28:14 INFO - 'tpaint', 22:28:14 INFO - 'sessionrestore', 22:28:14 INFO - 'sessionrestore_no_auto_restore']}, 22:28:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:28:14 INFO - 'tests': ['a11yr', 22:28:14 INFO - 'ts_paint', 22:28:14 INFO - 'tpaint', 22:28:14 INFO - 'sessionrestore', 22:28:14 INFO - 'sessionrestore_no_auto_restore']}, 22:28:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:28:14 INFO - 'tests': ['a11yr', 22:28:14 INFO - 'ts_paint', 22:28:14 INFO - 'tpaint', 22:28:14 INFO - 'sessionrestore', 22:28:14 INFO - 'sessionrestore_no_auto_restore']}, 22:28:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:28:14 INFO - 'tests': ['a11yr', 22:28:14 INFO - 'ts_paint', 22:28:14 INFO - 'tpaint', 22:28:14 INFO - 'sessionrestore', 22:28:14 INFO - 'sessionrestore_no_auto_restore']}, 22:28:14 INFO - 'other_l64': {'tests': ['a11yr', 22:28:14 INFO - 'ts_paint', 22:28:14 INFO - 'tpaint', 22:28:14 INFO - 'sessionrestore', 22:28:14 INFO - 'sessionrestore_no_auto_restore']}, 22:28:14 INFO - 'other_nol64': {'tests': ['a11yr', 22:28:14 INFO - 'ts_paint', 22:28:14 INFO - 'tpaint', 22:28:14 INFO - 'sessionrestore', 22:28:14 INFO - 'sessionrestore_no_auto_restore']}, 22:28:14 INFO - 'svgr': {'tests': ['tsvgx', 22:28:14 INFO - 'tsvgr_opacity', 22:28:14 INFO - 'tart', 22:28:14 INFO - 'tscrollx', 22:28:14 INFO - 'cart']}, 22:28:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:28:14 INFO - 'tests': ['tsvgx', 22:28:14 INFO - 'tsvgr_opacity', 22:28:14 INFO - 'tart', 22:28:14 INFO - 'tscrollx', 22:28:14 INFO - 'cart']}, 22:28:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:14 INFO - 'tests': ['tp5o']}, 22:28:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:14 INFO - 'talos_options': ['--e10s'], 22:28:14 INFO - 'tests': ['tp5o']}, 22:28:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:14 INFO - 'talos_options': ['--xperf_path', 22:28:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:28:14 INFO - 'tests': ['tp5n']}, 22:28:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:28:14 INFO - 'talos_options': ['--e10s', 22:28:14 INFO - '--xperf_path', 22:28:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"', 22:28:14 INFO - 'C:/slave/talos-data/talos/xperf.config'], 22:28:14 INFO - 'tests': ['tp5n']}}, 22:28:14 INFO - 'talos.zip': {'path': '', 22:28:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:28:14 INFO - Running post-action listener: _resource_record_post_action 22:28:14 INFO - ##### 22:28:14 INFO - ##### Running create-virtualenv step. 22:28:14 INFO - ##### 22:28:14 INFO - Running pre-action listener: _resource_record_pre_action 22:28:14 INFO - Running main action method: create_virtualenv 22:28:14 INFO - Creating virtualenv /builds/slave/test/build/venv 22:28:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:28:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:28:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:28:14 INFO - Using real prefix '/tools/python27' 22:28:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:28:16 INFO - Installing distribute.............................................................................................................................................................................................done. 22:28:20 INFO - Installing pip.................done. 22:28:20 INFO - Return code: 0 22:28:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:28: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')]} 22:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28: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')]} 22:28:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:20 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 0x10e444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a34a2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f99f0>, '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 0x10e158cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3c3990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/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.enrs6DKQA6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:28:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/Render', 22:28:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:20 INFO - 'HOME': '/Users/cltbld', 22:28:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:20 INFO - 'LOGNAME': 'cltbld', 22:28:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:20 INFO - 'MOZ_NO_REMOTE': '1', 22:28:20 INFO - 'NO_EM_RESTART': '1', 22:28:20 INFO - 'PAGER': '/bin/cat', 22:28:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:20 INFO - 'PWD': '/builds/slave/test', 22:28:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:20 INFO - 'SHELL': '/bin/bash', 22:28:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.enrs6DKQA6/Listeners', 22:28:20 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 22:28:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:20 INFO - 'USER': 'cltbld', 22:28:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:20 INFO - 'XPC_FLAGS': '0x0', 22:28:20 INFO - 'XPC_SERVICE_NAME': '0', 22:28:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:28:21 INFO - Cleaning up... 22:28:21 INFO - Return code: 0 22:28:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:28: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')]} 22:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28: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')]} 22:28:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:21 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 0x10e444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a34a2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f99f0>, '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 0x10e158cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3c3990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/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.enrs6DKQA6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:28:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:28:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:28:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/Render', 22:28:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:21 INFO - 'HOME': '/Users/cltbld', 22:28:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:21 INFO - 'LOGNAME': 'cltbld', 22:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:21 INFO - 'MOZ_NO_REMOTE': '1', 22:28:21 INFO - 'NO_EM_RESTART': '1', 22:28:21 INFO - 'PAGER': '/bin/cat', 22:28:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:21 INFO - 'PWD': '/builds/slave/test', 22:28:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:21 INFO - 'SHELL': '/bin/bash', 22:28:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.enrs6DKQA6/Listeners', 22:28:21 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 22:28:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:21 INFO - 'USER': 'cltbld', 22:28:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:21 INFO - 'XPC_FLAGS': '0x0', 22:28:21 INFO - 'XPC_SERVICE_NAME': '0', 22:28:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:28:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:21 INFO - Downloading/unpacking psutil>=0.7.1 22:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:24 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:28:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:28:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:28:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:28:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:28:24 INFO - Installing collected packages: psutil 22:28:24 INFO - Running setup.py install for psutil 22:28:24 INFO - building 'psutil._psutil_osx' extension 22:28:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 22:28:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 22:28:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 22:28:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 22:28:26 INFO - building 'psutil._psutil_posix' extension 22:28:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 22:28:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:28:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:28:27 INFO - ^ 22:28:27 INFO - 1 warning generated. 22:28:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 22:28:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:28:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:28:27 INFO - Successfully installed psutil 22:28:27 INFO - Cleaning up... 22:28:27 INFO - Return code: 0 22:28:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:27 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 0x10e444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a34a2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f99f0>, '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 0x10e158cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3c3990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/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.enrs6DKQA6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:28:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:28:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/Render', 22:28:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:27 INFO - 'HOME': '/Users/cltbld', 22:28:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:27 INFO - 'LOGNAME': 'cltbld', 22:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:27 INFO - 'MOZ_NO_REMOTE': '1', 22:28:27 INFO - 'NO_EM_RESTART': '1', 22:28:27 INFO - 'PAGER': '/bin/cat', 22:28:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:27 INFO - 'PWD': '/builds/slave/test', 22:28:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:27 INFO - 'SHELL': '/bin/bash', 22:28:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.enrs6DKQA6/Listeners', 22:28:27 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 22:28:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:27 INFO - 'USER': 'cltbld', 22:28:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:27 INFO - 'XPC_FLAGS': '0x0', 22:28:27 INFO - 'XPC_SERVICE_NAME': '0', 22:28:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:28:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:28:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:28:30 INFO - Installing collected packages: mozsystemmonitor 22:28:30 INFO - Running setup.py install for mozsystemmonitor 22:28:30 INFO - Successfully installed mozsystemmonitor 22:28:30 INFO - Cleaning up... 22:28:30 INFO - Return code: 0 22:28:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:30 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 0x10e444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a34a2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f99f0>, '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 0x10e158cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3c3990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/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.enrs6DKQA6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:28:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/Render', 22:28:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:30 INFO - 'HOME': '/Users/cltbld', 22:28:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:30 INFO - 'LOGNAME': 'cltbld', 22:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:30 INFO - 'MOZ_NO_REMOTE': '1', 22:28:30 INFO - 'NO_EM_RESTART': '1', 22:28:30 INFO - 'PAGER': '/bin/cat', 22:28:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:30 INFO - 'PWD': '/builds/slave/test', 22:28:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:30 INFO - 'SHELL': '/bin/bash', 22:28:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.enrs6DKQA6/Listeners', 22:28:30 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 22:28:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:30 INFO - 'USER': 'cltbld', 22:28:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:30 INFO - 'XPC_FLAGS': '0x0', 22:28:30 INFO - 'XPC_SERVICE_NAME': '0', 22:28:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:31 INFO - Downloading/unpacking blobuploader==1.2.4 22:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:34 INFO - Downloading blobuploader-1.2.4.tar.gz 22:28:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:28:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:28:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:35 INFO - Downloading docopt-0.6.1.tar.gz 22:28:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:28:35 INFO - Installing collected packages: blobuploader, requests, docopt 22:28:35 INFO - Running setup.py install for blobuploader 22:28:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:28:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:28:35 INFO - Running setup.py install for requests 22:28:36 INFO - Running setup.py install for docopt 22:28:36 INFO - Successfully installed blobuploader requests docopt 22:28:36 INFO - Cleaning up... 22:28:36 INFO - Return code: 0 22:28:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:36 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 0x10e444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a34a2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f99f0>, '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 0x10e158cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3c3990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/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.enrs6DKQA6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:28:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:28:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:28:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/Render', 22:28:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:36 INFO - 'HOME': '/Users/cltbld', 22:28:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:36 INFO - 'LOGNAME': 'cltbld', 22:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:36 INFO - 'MOZ_NO_REMOTE': '1', 22:28:36 INFO - 'NO_EM_RESTART': '1', 22:28:36 INFO - 'PAGER': '/bin/cat', 22:28:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:36 INFO - 'PWD': '/builds/slave/test', 22:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:36 INFO - 'SHELL': '/bin/bash', 22:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.enrs6DKQA6/Listeners', 22:28:36 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 22:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:36 INFO - 'USER': 'cltbld', 22:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:36 INFO - 'XPC_FLAGS': '0x0', 22:28:36 INFO - 'XPC_SERVICE_NAME': '0', 22:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:28:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:28:37 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-2g6jrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:28:37 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-W9QpDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:28:37 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-nb4KKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:28:37 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-oGYTAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:28:37 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-J92_X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:28:37 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-YFwcAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:28:37 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-Kyv0jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:28:38 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-eXh9R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:28:38 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-Z0_5sT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:28:38 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-t5DYnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:28:38 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-5GLwXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:28:38 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-GkK0RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:28:38 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-8ypDUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:28:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:28:38 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-Sz1gGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:39 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-nNDcdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:28:39 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-kwkCml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:28:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:28:39 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-LfscxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:28:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:28:39 INFO - Running setup.py install for manifestparser 22:28:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:28:39 INFO - Running setup.py install for mozcrash 22:28:39 INFO - Running setup.py install for mozdebug 22:28:40 INFO - Running setup.py install for mozdevice 22:28:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Running setup.py install for mozfile 22:28:40 INFO - Running setup.py install for mozhttpd 22:28:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Running setup.py install for mozinfo 22:28:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Running setup.py install for mozInstall 22:28:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:28:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:28:41 INFO - Running setup.py install for mozleak 22:28:41 INFO - Running setup.py install for mozlog 22:28:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:28:41 INFO - Running setup.py install for moznetwork 22:28:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:28:41 INFO - Running setup.py install for mozprocess 22:28:41 INFO - Running setup.py install for mozprofile 22:28:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:28:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:28:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:28:42 INFO - Running setup.py install for mozrunner 22:28:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:28:42 INFO - Running setup.py install for mozscreenshot 22:28:42 INFO - Running setup.py install for moztest 22:28:42 INFO - Running setup.py install for mozversion 22:28:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:28:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:28:42 INFO - Cleaning up... 22:28:42 INFO - Return code: 0 22:28:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10e444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a34a2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f99f0>, '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 0x10e158cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3c3990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/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.enrs6DKQA6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:28:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:28:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/Render', 22:28:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:42 INFO - 'HOME': '/Users/cltbld', 22:28:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:42 INFO - 'LOGNAME': 'cltbld', 22:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:42 INFO - 'MOZ_NO_REMOTE': '1', 22:28:42 INFO - 'NO_EM_RESTART': '1', 22:28:42 INFO - 'PAGER': '/bin/cat', 22:28:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:42 INFO - 'PWD': '/builds/slave/test', 22:28:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:42 INFO - 'SHELL': '/bin/bash', 22:28:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.enrs6DKQA6/Listeners', 22:28:42 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 22:28:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:42 INFO - 'USER': 'cltbld', 22:28:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:42 INFO - 'XPC_FLAGS': '0x0', 22:28:42 INFO - 'XPC_SERVICE_NAME': '0', 22:28:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:28:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:28:43 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-cW3CT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:28:43 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-zyWJQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:28:43 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-dd6F86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:28:43 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-jwJUfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:28:43 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)) 22:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:28:43 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-dEA6Ey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:28:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:28:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:28:43 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-yrteMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:28:44 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-D4VP25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:28:44 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)) 22:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:28:44 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-KOkkRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:28:44 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-yJ3WkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:28:44 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-4iDi1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:28:44 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-x81Kje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:28:44 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-dyj4Jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:28:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:28:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:28:44 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-Xi_Uf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:28:45 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-YDChCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:45 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-IpXH0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:28:45 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-MS2okr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:28:45 INFO - Running setup.py (path:/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/pip-ffs4dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:28:45 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)) 22:28:45 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)) 22:28:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:28:48 INFO - Downloading blessings-1.5.1.tar.gz 22:28:48 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:28:48 INFO - Installing collected packages: blessings 22:28:48 INFO - Running setup.py install for blessings 22:28:48 INFO - Successfully installed blessings 22:28:48 INFO - Cleaning up... 22:28:48 INFO - Return code: 0 22:28:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:28:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:28:49 INFO - Reading from file tmpfile_stdout 22:28:49 INFO - Current package versions: 22:28:49 INFO - blessings == 1.5.1 22:28:49 INFO - blobuploader == 1.2.4 22:28:49 INFO - docopt == 0.6.1 22:28:49 INFO - manifestparser == 1.1 22:28:49 INFO - mozInstall == 1.12 22:28:49 INFO - mozcrash == 0.16 22:28:49 INFO - mozdebug == 0.1 22:28:49 INFO - mozdevice == 0.47 22:28:49 INFO - mozfile == 1.2 22:28:49 INFO - mozhttpd == 0.7 22:28:49 INFO - mozinfo == 0.9 22:28:49 INFO - mozleak == 0.1 22:28:49 INFO - mozlog == 3.0 22:28:49 INFO - moznetwork == 0.27 22:28:49 INFO - mozprocess == 0.22 22:28:49 INFO - mozprofile == 0.27 22:28:49 INFO - mozrunner == 6.11 22:28:49 INFO - mozscreenshot == 0.1 22:28:49 INFO - mozsystemmonitor == 0.0 22:28:49 INFO - moztest == 0.7 22:28:49 INFO - mozversion == 1.4 22:28:49 INFO - psutil == 3.1.1 22:28:49 INFO - requests == 1.2.3 22:28:49 INFO - wsgiref == 0.1.2 22:28:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28: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 0x10e444a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e4b1228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f99a34a2fa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3f99f0>, '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 0x10e158cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3c3990>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/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.enrs6DKQA6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:28: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 22:28: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 22:28:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/Render', 22:28:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:49 INFO - 'HOME': '/Users/cltbld', 22:28:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:49 INFO - 'LOGNAME': 'cltbld', 22:28:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:49 INFO - 'MOZ_NO_REMOTE': '1', 22:28:49 INFO - 'NO_EM_RESTART': '1', 22:28:49 INFO - 'PAGER': '/bin/cat', 22:28:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:49 INFO - 'PWD': '/builds/slave/test', 22:28:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:49 INFO - 'SHELL': '/bin/bash', 22:28:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.enrs6DKQA6/Listeners', 22:28:49 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 22:28:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:49 INFO - 'USER': 'cltbld', 22:28:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:49 INFO - 'XPC_FLAGS': '0x0', 22:28:49 INFO - 'XPC_SERVICE_NAME': '0', 22:28:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:28:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28: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)) 22:28: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)) 22:28: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)) 22:28: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)) 22:28: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)) 22:28: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)) 22:28: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)) 22:28: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)) 22:28: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)) 22:28: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)) 22:28: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)) 22:28:49 INFO - Cleaning up... 22:28:49 INFO - Return code: 0 22:28:49 INFO - Running post-action listener: _resource_record_post_action 22:28:49 INFO - Running post-action listener: _start_resource_monitoring 22:28:49 INFO - Starting resource monitoring. 22:28:49 INFO - ##### 22:28:49 INFO - ##### Running install step. 22:28:49 INFO - ##### 22:28:49 INFO - Running pre-action listener: _resource_record_pre_action 22:28:49 INFO - Running main action method: install 22:28:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:28:50 INFO - Reading from file tmpfile_stdout 22:28:50 INFO - Detecting whether we're running mozinstall >=1.0... 22:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:28:50 INFO - Reading from file tmpfile_stdout 22:28:50 INFO - Output received: 22:28:50 INFO - Usage: mozinstall [options] installer 22:28:50 INFO - Options: 22:28:50 INFO - -h, --help show this help message and exit 22:28:50 INFO - -d DEST, --destination=DEST 22:28:50 INFO - Directory to install application into. [default: 22:28:50 INFO - "/builds/slave/test"] 22:28:50 INFO - --app=APP Application being installed. [default: firefox] 22:28:50 INFO - mkdir: /builds/slave/test/build/application 22:28: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'] 22:28: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 22:29:33 INFO - Reading from file tmpfile_stdout 22:29:33 INFO - Output received: 22:29:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:29:33 INFO - Running post-action listener: _resource_record_post_action 22:29:33 INFO - ##### 22:29:33 INFO - ##### Running run-tests step. 22:29:33 INFO - ##### 22:29:33 INFO - Running pre-action listener: _resource_record_pre_action 22:29:33 INFO - Running main action method: run_tests 22:29:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:29:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:29:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:29:33 INFO - 2015-11-04 22:29:33.533 screenresolution[1630:8286] starting screenresolution argv=screenresolution get 22:29:33 INFO - 2015-11-04 22:29:33.537 screenresolution[1630:8286] Display 0: 1600x1200x32@60 22:29:33 INFO - 2015-11-04 22:29:33.544 screenresolution[1631:8288] starting screenresolution argv=screenresolution list 22:29:33 INFO - Available Modes on Display 0 22:29:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:29:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:29:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:29:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:29:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:29:33 INFO - Intel HD Graphics 3000: 22:29:33 INFO - Chipset Model: Intel HD Graphics 3000 22:29:33 INFO - Type: GPU 22:29:33 INFO - Bus: Built-In 22:29:33 INFO - VRAM (Total): 512 MB 22:29:33 INFO - VRAM (Dynamic, Max): 10 22:29:33 INFO - Vendor: Intel (0x8086) 22:29:33 INFO - Device ID: 0x0116 22:29:33 INFO - Revision ID: 0x0009 22:29:33 INFO - Displays: 22:29:33 INFO - Display: 22:29:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:29:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:29:33 INFO - Display Serial Number: 1600x1200 60 22:29:33 INFO - Main Display: Yes 22:29:33 INFO - Mirror: Off 22:29:33 INFO - Online: Yes 22:29:33 INFO - Rotation: Supported 22:29:33 INFO - Return code: 0 22:29:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:29:33 INFO - Python 2.7.3 22:29:33 INFO - Return code: 0 22:29:33 INFO - grabbing minidump binary from tooltool 22:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:29:33 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 0x10e3f99f0>, '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 0x10e158cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e3c3990>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:29:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:29:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 22:29:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:29:33 INFO - Return code: 0 22:29:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:29:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:29:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:29:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:29:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:29:33 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/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0033', '--webServer', 'localhost'] in /builds/slave/test/build 22:29:33 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/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0033 --webServer localhost 22:29:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4whKtRhu4K/Render', 22:29:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:29:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:29:33 INFO - 'HOME': '/Users/cltbld', 22:29:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:29:33 INFO - 'LOGNAME': 'cltbld', 22:29:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:29:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:29:33 INFO - 'MOZ_NO_REMOTE': '1', 22:29:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:29:33 INFO - 'NO_EM_RESTART': '1', 22:29:33 INFO - 'PAGER': '/bin/cat', 22:29:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:29:33 INFO - 'PWD': '/builds/slave/test', 22:29:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:29:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:29:33 INFO - 'SHELL': '/bin/bash', 22:29:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.enrs6DKQA6/Listeners', 22:29:33 INFO - 'TMPDIR': '/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/', 22:29:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:29:33 INFO - 'USER': 'cltbld', 22:29:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:29:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:29:33 INFO - 'XPC_FLAGS': '0x0', 22:29:33 INFO - 'XPC_SERVICE_NAME': '0', 22:29:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:29:33 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/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0033', '--webServer', 'localhost'] with output_timeout 3600 22:29:34 INFO - mozversion INFO | application_buildid: 20151104204536 22:29:34 INFO - mozversion INFO | application_changeset: eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c 22:29:34 INFO - mozversion INFO | application_display_name: Nightly 22:29:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:29:34 INFO - mozversion INFO | application_name: Firefox 22:29:34 INFO - mozversion INFO | application_remotingname: firefox 22:29:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:29:34 INFO - mozversion INFO | application_vendor: Mozilla 22:29:34 INFO - mozversion INFO | application_version: 45.0a1 22:29:34 INFO - mozversion INFO | platform_buildid: 20151104204536 22:29:34 INFO - mozversion INFO | platform_changeset: eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c 22:29:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:29:34 INFO - mozversion INFO | platform_version: 45.0a1 22:29:34 INFO - 2015-11-04 22:29:34,322 DEBUG : using testdate: 1446704974 22:29:34 INFO - 2015-11-04 22:29:34,322 DEBUG : actual date: 1446704974 22:29:34 INFO - 2015-11-04 22:29:34,373 INFO : starting webserver on 'localhost:49270' 22:29:34 INFO - 2015-11-04 22:29:34,374 INFO : Starting test suite t-yosemite-r5-0033 22:29:34 INFO - 2015-11-04 22:29:34,374 INFO : Starting test dromaeo_css 22:29:34 INFO - 2015-11-04 22:29:34,374 DEBUG : operating with platform_type : mac_ 22:29:34 INFO - 2015-11-04 22:29:34,375 INFO : Initialising browser for dromaeo_css test... 22:29:34 INFO - 2015-11-04 22:29:34,402 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpkvmwga/profile http://localhost:49270/getInfo.html 22:29:37 INFO - 2015-11-04 22:29:37,586 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:29:37 INFO - 2015-11-04 22:29:37,586 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:29:37 INFO - 2015-11-04 22:29:37,586 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:29:37 INFO - 2015-11-04 22:29:37,586 DEBUG : BROWSER_OUTPUT: __metrics 22:29:37 INFO - 2015-11-04 22:29:37,603 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:29:38 INFO - 2015-11-04 22:29:38,423 INFO : Browser initialized. 22:29:38 INFO - 2015-11-04 22:29:38,424 INFO : Running cycle 1/1 for dromaeo_css test... 22:29:38 INFO - 2015-11-04 22:29:38,424 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpkvmwga/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:29:50 INFO - 2015-11-04 22:29:50,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 221769728 22:29:50 INFO - 2015-11-04 22:29:50,591 DEBUG : BROWSER_OUTPUT: 22:30:42 INFO - 2015-11-04 22:30:42,442 DEBUG : BROWSER_OUTPUT: 1446705042433 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:32:52 INFO - 2015-11-04 22:32:52,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 22:32:53 INFO - 2015-11-04 22:32:53,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 326000640 22:32:53 INFO - 2015-11-04 22:32:53,614 DEBUG : BROWSER_OUTPUT: 22:35:56 INFO - 2015-11-04 22:35:56,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 22:35:57 INFO - 2015-11-04 22:35:57,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 353931264 22:35:57 INFO - 2015-11-04 22:35:57,125 DEBUG : BROWSER_OUTPUT: 22:38:59 INFO - 2015-11-04 22:38:59,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 22:39:00 INFO - 2015-11-04 22:39:00,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 315514880 22:39:00 INFO - 2015-11-04 22:39:00,106 DEBUG : BROWSER_OUTPUT: 22:42:02 INFO - 2015-11-04 22:42:02,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 22:42:02 INFO - 2015-11-04 22:42:02,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 310677504 22:42:02 INFO - 2015-11-04 22:42:02,860 DEBUG : BROWSER_OUTPUT: 22:45:06 INFO - 2015-11-04 22:45:06,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 22:45:06 INFO - 2015-11-04 22:45:06,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 311537664 22:45:06 INFO - 2015-11-04 22:45:06,652 DEBUG : BROWSER_OUTPUT: 22:48:09 INFO - 2015-11-04 22:48:09,548 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 22:48:09 INFO - 2015-11-04 22:48:09,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 356286464 22:48:09 INFO - 2015-11-04 22:48:09,806 DEBUG : BROWSER_OUTPUT: 22:48:09 INFO - 2015-11-04 22:48:09,806 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:48:09 INFO - 2015-11-04 22:48:09,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:48:09 INFO - 2015-11-04 22:48:09,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:48:09 INFO - 2015-11-04 22:48:09,806 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:48:09 INFO - 2015-11-04 22:48:09,807 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2563.8461692298465;2627.9080232191864;2651.1781347782176;2655.4689062187567;2656.25624825049;4151.128263064753;4314.417553630259;4335.86992390228;4385.627221686156;4466.330050492424;4310.5904939030825;4326.06989497258;4352.325389564622;4409.228385032622;4468.0170362520275;3953.7430067045693;3992.021954621122;4035.9506528302704;4059.8985025374304;4073.5111786585653;4049.9797501012454;4090.14107037521;4112.712110152291;4123.36087906375;4165.375193720935;3872.5740168581715;3978.1844721831953;3986.86045988389;4044.1102957349335;4166.333386658135;4020.9396859047138;4076.510818701745;4090.0388408723925;4111.671066314688;4113.609207125318;4010.83956641734;4024.0342317843506;4059.6955228357697;4060.5127384714024;4116.897077573085;4191.874243772661;4249.915001699948;4303.053328267776;4311.353297005474;4383.846565370229;4596.954030459686;4597.080583883203;4620.052889157748;4708.0819240248165;4721.952780472186;4641.141388843075;4641.791119399635;4678.228092364756;4732;4785.641076919245;4301.698881078357;4348.152110338517;4349.695521313541;4354.716943398669;4383.057642606823;4717.693349932243;4796.232602783608;4843.733594652257;4885.169521181337;4898.730569818623;4629.1436084324505;4638.83764068256;4648.6745927785405;4651.116287905287;4726.078414709167;4483.21543729846;4555.33947577606;4584.862454126382;4707.129181101507;4839.032193561302;4641.048585040058;4646.8141274348645;4647.535246475393;4697.953020469751;4709.458412282632;4630.3748993886065;4647.674662773574;4656.8602941911795;4682.227432473672;4696.647751418657;3530.876419325363;3612.5845527764645;3613.8012409317216;3626.5829429615405;3659.908502287411;3312.519684645761;3322.8172450515453;3341.7827841190247;3350.748693847971;3356.0938546592283;4389.3415987601475;4401;4404.273294906368;4407.537208593116;4527;4477.529859364719;4605.240135377692;4619.307103934437;4652.418447694038;4718.079974404958;4380.934285985712;4384.8246070157475;4386;4433.290673492225;4470.307102399133;4118.897027574335;4130.545639979599;4136.503619565671;4167.604077612622;4242.915141697149;4599.241125214369;4626.606738427136;4670.276107203457;4733.219018861849;4738.597219236334;4716.551927566876;4740.549647783455;4751.501092385388;4765.0946320199055;4790.257510085942;4749.35883655702;4766.928496072493;4770.236762118045;4784.6889952153;4789.425268967746;4434.689571730077;4525.841595544141;4538.387317712199;4613.469451013177;4690.788914498788;4674.298855171752;4688.2733176357715;4700.858974230779;4732.432108147044;4770.666053376231;4551;4560.794764235551;4576.427946506687;4593.908121837611;4666.766661666971;4224.725392849455;4248.617624413818;4375.256206444848;4501.977490112659;4539.364488971612;4444.933326000178;4496.4154659894;4499.347594598699;4502.099580083931;4567.497575266651;4588.3805686231935;4592.586667199968;4606.493285738499;4609.377734005866;4639.5128511507155;4283.336082907154;4385.386045953633;4391.341298805205;4402.405675233803;4493.977530112328 22:48:09 INFO - 2015-11-04 22:48:09,812 DEBUG : BROWSER_OUTPUT: |1;ext.html;451.81701410928576;462.18885855323924;463.3374274787053;473.9004808990112;491.9398695810525;25940.61089083663;27336.17991460257;32301.353972920526;32966;33442.8327858361;35190.648093519056;35237.295254094905;35264.29471410577;35300.470492942564;35828.82085589568;6729.596224226538;7584;7620.733274335399;7647.770566882975;7768.145503994556;6828.531865648884;9037.141471560224;9199.95400022999;9226.538673066354;9339.15947564719;8840.38117331787;9072.59173337198;9108.681196158135;9119.635214591408;9154.26765858733;6894.13823272091;7064.611446370448;7096.219415864251;8938.240249578761;9063.909360906406;8688.869666955;8900.599473023665;8914.687985920462;8931.285497160277;9085.227755640779;30160.8491957541;30505.847470762725;30600.8469957651;31054.37891242185;31091.689083109104;2435.232901635979;2607.3351295419548;2656.787457003435;2742.204760619418;2965.584818125464;22330.88834555833;22632.321030369116;22772;23013.53972920532;23284.76715232843;1912.6270377276437;1914.9329773458;1941.5049162463622;1945.1246938877562;1961.431184956361;215380;216229;217360;217633;218726.90636546875;49806.50193498019;49811;49880.750596246784;49921.251181232314;49931.25103123456;47500.76249618799;49102.26346604804;49199.75400122976;52442;52863.20705189425;13559.864401356057;13893.58319250424;13992.23042732639;14127.78808317876;14163.079399838978;10476.266661333786;10527.578896844041;10576.259661823598;10692;10771.299865508718;16265.349386024664;16269.918650406673;16287;16358.754618680729;16380.672386552202;7133.678984445609;7135.357817796424;7211.963940180265;7273.599952002691;7275.454340924346;748.7341993592305;765.1239330966013;810.691937063912;899.5547204133995;906.5376657904384;21265.577277794062;21660.35018949434;21682.457938551346;21709;21726.13095476195;863.6631713631689;879.4547380624055;947;954.346272803132;1021.1779517488345;11208.383538905438;11427.542898284142;11505.397840863721;11607.825882611767;11652.592159274385;235220;235544;237935;238936;239525;44557.554424455986;44814.55185448169;44964;45763;45786;1019.8470229465491;1048.6067724603427;1049.296971029397;1153.400231879418;1164.6564263542107;17753.381034753853;21981.780182197974;23152.53694926126;24154.51690966206;24179.879100604383;42343;42422;42707.786461067495;43174.78412607917;43234.783826081926;227658;231047;232435;281167;284005;25335.746642534075;26504.602430963165;26811.865940670174;26925.192244232705;26946.865265673547;28270.575941360486;28528.144155675363;28772;28869.711302886702;28911.56632650554;26419.735802641728;27111.499562991634;27874.16377508678;28391.716082839732;28579.28551786222;27972.30069248285;28111.00627517928;28590.285242869093;28669;28763;28961.7103828959;29276.56085158682;29302.70697293085;29775.404491910474;29797.85101074481;23927.28218153458;25780.613290800276;25847.870760646078;25937.481250375266;26407.339816503973;19379.51551211231;19380;19439.125239364545;19539.902300488975;19584.706229406285 22:48:09 INFO - 2015-11-04 22:48:09,812 DEBUG : BROWSER_OUTPUT: |2;jquery.html;272.7095643140057;274.2007049450851;275.1923105684817;277.79165625780666;283.8779324890297;13905.652358691024;14226.857731422682;14371.209583472917;14589.635259118528;15562.688746225069;11821.468033938472;12135.696607584814;12488.562900298492;12519.874801251985;15154.6969060619;4249.362595610668;4407.493138289105;4438.933415998747;4486.97756511217;4515.706479078865;3658.3414985302634;3795.582485926546;3873.2640798248385;4355.085432059255;4443.822247110112;2708.6614173228345;2784.470950519405;2789.511835428792;3728.757630753992;3804.4673745675627;3760.680342170905;3838.0788610733503;3841.78870162141;3870.8838734838;3925.1953349563555;3303.801771893694;3308.503724441353;3312.1719570107475;3316.817575033372;3319.0872510059685;10442.63450779219;10667.093297069758;10668.093212076983;10681.465926703711;10698.839517407245;1287.748888966652;1309.508934149694;1348.9123206991515;1518.5064853922408;1584.6672198838141;7521.24787521249;7694.1847899163495;7701.961490192569;7796.961015194945;7956.482828616122;1223.5962132496343;1234.9506019759199;1248.5692436109528;1268.0362924177691;1272.694553307209;45664;46295.30557041647;46749.532504674855;48069.5193048072;48437.75781121107;5124.308978037238;5132.30713853625;5159.226116082617;5233.058049551041;5290.867728306823;5888.205092312483;5900.085486749561;6027.939720602825;6028.758849646053;6034.517238620988;4350.630196433339;4394.604485596312;4438.068005718771;4439.156560253606;4452.577005184502;4699.224627936421;4734.431868175841;4740.976295118502;4832.685875418087;4844.442889067803;2317.953640927172;2333.661619065226;2343.847649902751;2346.979064107119;2386.8687222202598;820.7742870710603;824.1387749801472;827.9172082791673;851.3870013590329;892.4199270474244;335.2640953107905;345.481777333999;347.633246924492;354.96982756465474;362.7859562857926;7804.219578042151;9105.635774569075;9327.766805829908;9416.670416535388;9514;320.8299601211362;366.71945961339594;369.5620689482971;378.54763557548466;379.07127537533154;4928.285398617252;5176.301199338041;5193.844184674465;5224.817131400383;5229.790808367698;475177;478950;481193;484450;490170;56341.43658563444;56378.71810641002;56392;56603.71698141565;56837.43162568404;397.5904818037426;402.3522129371709;402.4607026584391;402.65774092022133;409.5924555067667;8685;8807.163319484638;8812.42719223274;8892.688755893512;8931.285497160341;28095.71904280931;28321.57517637196;28638.57042144411;28993.7100628991;29042.27394315159;37793.433098502996;37853.43219851649;38025.61974380331;38296.808515957244;38623;4972.751362431936;5034.263179203169;5057.5448209659835;5060.266261392151;5151.665141765773;9534.666286679932;9589.712308630753;9683.128518433376;9699.466529340672;9838.75403114928;8071.798205044686;8186.754397368089;8453.323734101381;8509.74470765878;8545.487270763773;7686.192949740421;8105.959470202847;8199.139090395423;8362.372822038249;8533.658653653783;7937.801554960941;8349.457285276438;8661.826763464569;8678.78303042429;8780.25367843715;4353.3469979503325;4574.290984897346;4577.176108300538;4754.4770075291;4998.4501704813165;7827.178146294785;8197.672093116447;8225.177482251727;8228.094909559824;8234.752957411287 22:48:09 INFO - 2015-11-04 22:48:09,815 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1087.9619213327535;1143.502576379275;1171.6719318590797;1308.5093090091214;1458.883289336853;5259.447757985409;5536.916946245805;5628.915566266504;5725.7995970141055;5784.421557844214;5750.971245143779;5770.596058275912;5847.298324201101;5874.148248503964;5897.587168898179;1746.7816522934634;1757.3585641240918;1773.184335205807;1773.6807374672553;1775.1301862087614;1710.2816816936854;1767.19592585374;1768.796588392332;1775.3874913154941;1794.156746329223;1725.6031112844053;1748.3006797281062;1756.9121543922752;1757.2531674038482;1761.3130878957218;1709.265016043101;1728.5764987578061;1730.9134543272785;1732.5928406824387;1735.7309617009385;1711.9657606847793;1734.4363081998401;1740.721484562464;1742.9389971350943;1743.2329774899003;5394.622376433651;5835.095560188178;5843.737031833535;5846.561507886926;5853.678047707374;3353.832308384571;3431.9485207721905;3531.5055892175114;3676.1728611062563;3702.315071711715;2233.9776602234097;2290.6564015397657;2319.0723710515927;2322.7677232276637;2324.3840382298704;743.9218882017365;762.4015148108708;763.2939530933864;777.1412589089032;780.2041917244379;7332.816679582999;7549.396048316176;7551.811204719871;7559.28186822251;7564.848703025964;3195.2171717929255;3226.274088330154;3278.2951665392056;3336.199312165063;3349.7152742016715;6790.796276111724;6791.151106111736;6797.864042719118;6798.286179951034;6799.932000680029;3733.5519737631657;3739.794311312904;3742.1206016586625;3743.7753734776;3751.0622344413896;3396.3207358528393;3400.795952242873;3404.5403870477166;3405.540252065989;3409.641987591267;2755.145904769528;2802.957955630667;2815.577663350473;2833.4616422879585;2835.8723857426467;873.8121303919688;874.5233847553098;889.2707979456783;903.9412438191497;905.4929239625831;1058.7882423515173;1065.872095348563;1076.079951641351;1076.3541874875168;1100.7138144082596;5352.464753524694;5580.386157522669;5627.352854421794;5651.124075768263;5658.462446067617;374.9894035574156;379.37403284580114;961.4904100826573;990.1435258501344;1007.2043085962155;4393.51671316155;4541.137183935108;4546.227141385973;4551.931721024187;4553.977230113828;6427.100205971168;6549.279579246279;6555.868882622321;6560.671966401661;6822.522423430312;6719.865602687919;6740.662966851638;6754.662266886636;6764.255931847493;6775.627340496221;5446.319210098738;5473.233747275384;5532.695701736363;5542.334919809648;5545.085060964896;5488.560915126701;5542.61201715876;5556.972215138899;5560.4161563035295;5568.610197286151;5907.852303692442;6150.630962142286;6187.257529096537;6192.411720886508;6276;6226.564140510302;6242.250929888442;6249.0626406039455;6255.812325630239;6258.7809426671665;4969.155243608668;5055.87360315995;5059.772310245974;5060.418051924076;5066.341375621146;5634.577406694596;5660.405657406078;5666.660000399989;5672.716364181857;5741.91387129185;5227.686338819531;5299.152135658276;5314.707691077027;5373.865653358697;5392.056390131633;5205.427402985744;5221.608379371638;5274.97362513185;5282.630215885005;5302.787888484571;5347.919781203207;5373.032854086302;5383.892322153613;5384.6499977501335;5396.83809485716;4861.829835955725;4894.241392584155;4895.020995800783;4927.236278376714;4929.309896614549;4907.288443175791;4975.601951843916;5003.299538064746;5009.8747531310555;5016.598672106295 22:48:09 INFO - 2015-11-04 22:48:09,819 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.71556141560035;258.21888786421084;258.9925191006983;260.9399838037251;265.34327539340137;4777.665563410563;4905.215165573509;4923.138450771115;4928.753562321887;4930.802767889285;4801.879953001177;4886.584640305578;4916.287138364935;4916.729579873106;4916.729579873106;3610.729195310349;3679.816009199543;3692.02161427222;3794.1273507093383;3794.4118661607495;3746.0822098585886;3772.6604605585494;3798.9810050949704;3816.9427458588143;3830.9808450957707;3756.136088699601;3764.454154147647;3769.8115094245313;3772.320982223199;3782.7919464429447;3683.0976410779394;3754.2491501699633;3764.849406023756;3775.565809931838;3783.3379158647126;3258.25060236147;3266.0528446750413;3272.7381809455187;3282.14664187313;3288.901332959991;4657.371254880582;4751.14479393709;4782.1631214537665;4834.637402194814;4842.297866809328;4173.561776013536;4177.185448837478;4182.64447521961;4183.748975061476;4194.4337514435465;4957.107720610289;5125.333706618116;5135.152699804527;5137.614678899097;5152.072626927152;3396.0491062502538;3402.931941361184;3413.3343997920415;3454.758166928316;3473.548438702978;5253.86865328366;5280.128778751501;5319.228711836762;5383.43473935235;5412.161115027098;3497.143199916037;3498.4052711038676;3505.088676944013;3513.8594456221977;3515.068506845688;3538.9469157962653;3539.079839241764;3540.681338679531;3547.414676578387;3549.4853246279145;4055.91888162241;4123.587641235852;4131.35963925592;4198.412222288882;4228.154369126187;5214.374275087014;5224.8171314004585;5229.137192363218;5232.215167724796;5236.581073514109;1268.3277862732766;1294.0294778915813;1294.0359432222865;1294.4822071171607;1300.9349532523336;817.8773184022325;822.3010441125116;836.0176792269181;836.8410002099581;837.0499483086741;4987.426445958688;4989.850304490871;4999.675021123615;5016.172331565251;5027.069992051483;5424.267723857229;5424.972875135599;5429.049916264638;5451.291332126877;5525.640833345819;4987.850364489072;4994.250862370601;5002.549770520598;5008.373953255843;5110.974445127825;2908.7236712512276;2989.910302690923;3001.4147241288174;3020.7734419918156;3030.772692048105;5459.0173768721215;5459.153831156177;5486.231927530149;5488.4785945335125;5489.615726899079;5541.085720856095;5541.889162216814;5542.3626282977975;5570.86072848182;5651.12407576818;5445.2921120254905;5471.124620060851;5477.397486276506;5488;5539.279893613885;5255.500727430888;5304.07178743726;5396.406395296436;5431.293931788842;5433.7554810034435;5094.617903657315;5186.325777648882;5305.416404195613;5319.46805319465;5322.866928326823;5357.383900851296;5382.811601594082;5457.645253058538;5488.396276409671;5489.890202195854;3511.2099777549847;3545.8404371803845;3577.0520811984325;3578.051816268743;3586.5696116466193;5345.305110335631;5437.972810135924;5456.672599644034;5461.754221059982;5480.205370221216;5134.5635620972635;5222.503862133091;5264.947350526446;5274.657147285414;5294.708791016531;5259.763310651107;5272.393674727456;5280.1815718563685;5281.260623512634;5365.892682146413;5131.025105229995;5136.5377116059735;5137.794488220429;5149.897002059863;5163.483651634807;5087.364079490064;5277.683338999673;5280.128778751463;5291.550218231339;5294.338207724035;5177.767000485062;5179.766910489112;5181.3005244293045;5189.377274727057;5219.373675159005 22:48:09 INFO - 2015-11-04 22:48:09,819 DEBUG : BROWSER_OUTPUT: |5;yui.html;599.3497055694571;613.809718987114;619.5848781316517;623.3828509775321;632.181325183887;10947.726306842333;10997.570315858937;11204.775904481905;11376.715582110452;11381.601643942453;11270.09839212863;11425;11625.360605166712;11627.593034243802;11675.766484670301;581.9650820950757;583.1573376471001;674.4267372733186;714.8748968930443;741.9814504637374;571.7884382778378;715.967781449836;726.6040008195546;737.1854101218157;739.6523633892062;748.5172064018705;774.4578794843604;777.7783331750452;785.7917651822272;787.8896954426356;609.1259043272918;609.2688773471807;610.057461222408;770.1489853711624;782.8277778888664;557.4147145497212;571.6055921414211;572.3589579670754;572.3932631410718;576.5070864410952;11425.771484570261;11501.07991360689;11512.136589755719;11673.649790506299;11716.94141529287;9526.809463810754;9549.856752148724;9601.327907046509;9742.269329800223;9923.305368624198;7658.808529786744;7707.884381734279;7711.884321735179;7818.06183258007;7939.96030019852;2617.6073588961617;2640.93397665058;2701.13563659629;2754.118682021754;2768.958465623017;39300.803495982334;40114;40258.39612405816;40430.79784601058;40710.185796284204;7269.236730143259;7326.67029983652;7328.706851725978;7422.96288518554;7494.587797671181;15895.920520397323;15952.840471595135;16117.51647450555;16129.354825806837;16267.186640668157;5793.536517078624;5888.087346461305;5903.498202652822;5947.1079338099635;5952.85117872048;3167.4298626247496;3174.365126974614;3194.2174167329154;3227.9677203227666;3340.265141668829;2190.9561808763738;2241.9215327463785;2246.1689175005354;2269.137727663477;2273.556656451976;348.94765785131926;351.5658162169718;353.6887538965745;359.53440294818273;360.56371790134233;334.86605357857053;433.44235365135626;454.4138061900178;482.8599706085266;506.59978616892244;6200.968995154995;6276.497880169575;6375.617462952145;6416.615003099829;6464.612123272619;334.2502002019426;419.4295757769431;476.47825630934074;492.77578701690646;504.74762618690653;2954.9556756648667;3076.7538596912195;3285.5400243965864;3311.966880331166;3383.543221665044;39638.801805990784;39812.402813957815;40222.195556088715;40328.39507407391;40857.387139192935;39659;40063;40107.1978560433;40884;41398;37691.62308376881;37905.81047094747;38337.808310958826;38831;38971.02572435655;6443.7744678936015;6448.5163612730175;6626.337366263335;6741.325867413219;6770.390664840188;27685;28321.57517637196;28705;28812.711872881002;29075.709242908146;34276.657233427344;34890.82554587211;36845;38899.222015560095;39194;6085.543584231289;6124.846878828065;6182.072689096672;6304.71628776697;6316.05259211122;8746.387752857494;8759.430637008574;9005.684801031932;9158.633654654006;9639.421634701941;8354.206350396702;8357.95821020891;8389.874151887849;8431.578421079044;8514.063453020039;8157;8176.918230817853;8223.79440513968;8229.382796290183;8241.093479717347;7952.324052455375;8001.039875215011;8002.359811215205;8106.392020598597;8264.958675206586;7178.246284140299;7203.747868824566;7436.182019977907;7611.029551287831;7682.807929801576;6977.162740471176;6980.406665433292;7162.104736907887;7194.424446044409;7194.460415468965 22:48:09 INFO - 2015-11-04 22:48:09,819 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:48:09 INFO - 2015-11-04 22:48:09,820 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:48:09 INFO - 2015-11-04 22:48:09,820 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,984 22:48:09 INFO - 2015-11-04 22:48:09,821 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:48:09 INFO - 2015-11-04 22:48:09,821 DEBUG : BROWSER_OUTPUT: __startTimestamp1446706089804__endTimestamp 22:48:09 INFO - 2015-11-04 22:48:09,821 DEBUG : BROWSER_OUTPUT: 22:48:09 INFO - 2015-11-04 22:48:09,822 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:48:09 INFO - 2015-11-04 22:48:09,822 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:48:09 INFO - 2015-11-04 22:48:09,822 DEBUG : BROWSER_OUTPUT: 22:48:09 INFO - 2015-11-04 22:48:09,822 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4349.76 Median:4470.31 stddev:455.01 (10.2%) stddev-sans-first:434.30 22:48:09 INFO - 2015-11-04 22:48:09,822 DEBUG : BROWSER_OUTPUT: Values: 2563.8 2627.9 2651.2 2655.5 2656.3 4151.1 4314.4 4335.9 4385.6 4466.3 4310.6 4326.1 4352.3 4409.2 4468.0 3953.7 3992.0 4036.0 4059.9 4073.5 4050.0 4090.1 4112.7 4123.4 4165.4 3872.6 3978.2 3986.9 4044.1 4166.3 4020.9 4076.5 4090.0 4111.7 4113.6 4010.8 4024.0 4059.7 4060.5 4116.9 4191.9 4249.9 4303.1 4311.4 4383.8 4597.0 4597.1 4620.1 4708.1 4722.0 4641.1 4641.8 4678.2 4732.0 4785.6 4301.7 4348.2 4349.7 4354.7 4383.1 4717.7 4796.2 4843.7 4885.2 4898.7 4629.1 4638.8 4648.7 4651.1 4726.1 4483.2 4555.3 4584.9 4707.1 4839.0 4641.0 4646.8 4647.5 4698.0 4709.5 4630.4 4647.7 4656.9 4682.2 4696.6 3530.9 3612.6 3613.8 3626.6 3659.9 3312.5 3322.8 3341.8 3350.7 3356.1 4389.3 4401.0 4404.3 4407.5 4527.0 4477.5 4605.2 4619.3 4652.4 4718.1 4380.9 4384.8 4386.0 4433.3 4470.3 4118.9 4130.5 4136.5 4167.6 4242.9 4599.2 4626.6 4670.3 4733.2 4738.6 4716.6 4740.5 4751.5 4765.1 4790.3 4749.4 4766.9 4770.2 4784.7 4789.4 4434.7 4525.8 4538.4 4613.5 4690.8 4674.3 4688.3 4700.9 4732.4 4770.7 4551.0 4560.8 4576.4 4593.9 4666.8 4224.7 4248.6 4375.3 4502.0 4539.4 4444.9 4496.4 4499.3 4502.1 4567.5 4588.4 4592.6 4606.5 4609.4 4639.5 4283.3 4385.4 4391.3 4402.4 4494.0 22:48:09 INFO - 2015-11-04 22:48:09,823 DEBUG : BROWSER_OUTPUT: 22:48:09 INFO - 2015-11-04 22:48:09,823 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37558.51 Median:28584.79 stddev:61664.03 (215.7%) stddev-sans-first:61774.07 22:48:09 INFO - 2015-11-04 22:48:09,824 DEBUG : BROWSER_OUTPUT: Values: 451.8 462.2 463.3 473.9 491.9 25940.6 27336.2 32301.4 32966.0 33442.8 35190.6 35237.3 35264.3 35300.5 35828.8 6729.6 7584.0 7620.7 7647.8 7768.1 6828.5 9037.1 9200.0 9226.5 9339.2 8840.4 9072.6 9108.7 9119.6 9154.3 6894.1 7064.6 7096.2 8938.2 9063.9 8688.9 8900.6 8914.7 8931.3 9085.2 30160.8 30505.8 30600.8 31054.4 31091.7 2435.2 2607.3 2656.8 2742.2 2965.6 22330.9 22632.3 22772.0 23013.5 23284.8 1912.6 1914.9 1941.5 1945.1 1961.4 215380.0 216229.0 217360.0 217633.0 218726.9 49806.5 49811.0 49880.8 49921.3 49931.3 47500.8 49102.3 49199.8 52442.0 52863.2 13559.9 13893.6 13992.2 14127.8 14163.1 10476.3 10527.6 10576.3 10692.0 10771.3 16265.3 16269.9 16287.0 16358.8 16380.7 7133.7 7135.4 7212.0 7273.6 7275.5 748.7 765.1 810.7 899.6 906.5 21265.6 21660.4 21682.5 21709.0 21726.1 863.7 879.5 947.0 954.3 1021.2 11208.4 11427.5 11505.4 11607.8 11652.6 235220.0 235544.0 237935.0 238936.0 239525.0 44557.6 44814.6 44964.0 45763.0 45786.0 1019.8 1048.6 1049.3 1153.4 1164.7 17753.4 21981.8 23152.5 24154.5 24179.9 42343.0 42422.0 42707.8 43174.8 43234.8 227658.0 231047.0 232435.0 281167.0 284005.0 25335.7 26504.6 26811.9 26925.2 26946.9 28270.6 28528.1 28772.0 28869.7 28911.6 26419.7 27111.5 27874.2 28391.7 28579.3 27972.3 28111.0 28590.3 28669.0 28763.0 28961.7 29276.6 29302.7 29775.4 29797.9 23927.3 25780.6 25847.9 25937.5 26407.3 19379.5 19380.0 19439.1 19539.9 19584.7 22:48:09 INFO - 2015-11-04 22:48:09,824 DEBUG : BROWSER_OUTPUT: 22:48:09 INFO - 2015-11-04 22:48:09,825 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22774.95 Median:25089.85 stddev:78868.51 (314.3%) stddev-sans-first:79071.65 22:48:09 INFO - 2015-11-04 22:48:09,826 DEBUG : BROWSER_OUTPUT: Values: 272.7 274.2 275.2 277.8 283.9 13905.7 14226.9 14371.2 14589.6 15562.7 11821.5 12135.7 12488.6 12519.9 15154.7 4249.4 4407.5 4438.9 4487.0 4515.7 3658.3 3795.6 3873.3 4355.1 4443.8 2708.7 2784.5 2789.5 3728.8 3804.5 3760.7 3838.1 3841.8 3870.9 3925.2 3303.8 3308.5 3312.2 3316.8 3319.1 10442.6 10667.1 10668.1 10681.5 10698.8 1287.7 1309.5 1348.9 1518.5 1584.7 7521.2 7694.2 7702.0 7797.0 7956.5 1223.6 1235.0 1248.6 1268.0 1272.7 45664.0 46295.3 46749.5 48069.5 48437.8 5124.3 5132.3 5159.2 5233.1 5290.9 5888.2 5900.1 6027.9 6028.8 6034.5 4350.6 4394.6 4438.1 4439.2 4452.6 4699.2 4734.4 4741.0 4832.7 4844.4 2318.0 2333.7 2343.8 2347.0 2386.9 820.8 824.1 827.9 851.4 892.4 335.3 345.5 347.6 355.0 362.8 7804.2 9105.6 9327.8 9416.7 9514.0 320.8 366.7 369.6 378.5 379.1 4928.3 5176.3 5193.8 5224.8 5229.8 475177.0 478950.0 481193.0 484450.0 490170.0 56341.4 56378.7 56392.0 56603.7 56837.4 397.6 402.4 402.5 402.7 409.6 8685.0 8807.2 8812.4 8892.7 8931.3 28095.7 28321.6 28638.6 28993.7 29042.3 37793.4 37853.4 38025.6 38296.8 38623.0 4972.8 5034.3 5057.5 5060.3 5151.7 9534.7 9589.7 9683.1 9699.5 9838.8 8071.8 8186.8 8453.3 8509.7 8545.5 7686.2 8106.0 8199.1 8362.4 8533.7 7937.8 8349.5 8661.8 8678.8 8780.3 4353.3 4574.3 4577.2 4754.5 4998.5 7827.2 8197.7 8225.2 8228.1 8234.8 22:48:09 INFO - 2015-11-04 22:48:09,826 DEBUG : BROWSER_OUTPUT: 22:48:09 INFO - 2015-11-04 22:48:09,826 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4094.92 Median:5243.57 stddev:2040.05 (38.9%) stddev-sans-first:2033.25 22:48:09 INFO - 2015-11-04 22:48:09,828 DEBUG : BROWSER_OUTPUT: Values: 1088.0 1143.5 1171.7 1308.5 1458.9 5259.4 5536.9 5628.9 5725.8 5784.4 5751.0 5770.6 5847.3 5874.1 5897.6 1746.8 1757.4 1773.2 1773.7 1775.1 1710.3 1767.2 1768.8 1775.4 1794.2 1725.6 1748.3 1756.9 1757.3 1761.3 1709.3 1728.6 1730.9 1732.6 1735.7 1712.0 1734.4 1740.7 1742.9 1743.2 5394.6 5835.1 5843.7 5846.6 5853.7 3353.8 3431.9 3531.5 3676.2 3702.3 2234.0 2290.7 2319.1 2322.8 2324.4 743.9 762.4 763.3 777.1 780.2 7332.8 7549.4 7551.8 7559.3 7564.8 3195.2 3226.3 3278.3 3336.2 3349.7 6790.8 6791.2 6797.9 6798.3 6799.9 3733.6 3739.8 3742.1 3743.8 3751.1 3396.3 3400.8 3404.5 3405.5 3409.6 2755.1 2803.0 2815.6 2833.5 2835.9 873.8 874.5 889.3 903.9 905.5 1058.8 1065.9 1076.1 1076.4 1100.7 5352.5 5580.4 5627.4 5651.1 5658.5 375.0 379.4 961.5 990.1 1007.2 4393.5 4541.1 4546.2 4551.9 4554.0 6427.1 6549.3 6555.9 6560.7 6822.5 6719.9 6740.7 6754.7 6764.3 6775.6 5446.3 5473.2 5532.7 5542.3 5545.1 5488.6 5542.6 5557.0 5560.4 5568.6 5907.9 6150.6 6187.3 6192.4 6276.0 6226.6 6242.3 6249.1 6255.8 6258.8 4969.2 5055.9 5059.8 5060.4 5066.3 5634.6 5660.4 5666.7 5672.7 5741.9 5227.7 5299.2 5314.7 5373.9 5392.1 5205.4 5221.6 5275.0 5282.6 5302.8 5347.9 5373.0 5383.9 5384.6 5396.8 4861.8 4894.2 4895.0 4927.2 4929.3 4907.3 4975.6 5003.3 5009.9 5016.6 22:48:09 INFO - 2015-11-04 22:48:09,828 DEBUG : BROWSER_OUTPUT: 22:48:09 INFO - 2015-11-04 22:48:09,828 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4329.14 Median:5001.11 stddev:1327.19 (26.5%) stddev-sans-first:1295.15 22:48:09 INFO - 2015-11-04 22:48:09,829 DEBUG : BROWSER_OUTPUT: Values: 251.7 258.2 259.0 260.9 265.3 4777.7 4905.2 4923.1 4928.8 4930.8 4801.9 4886.6 4916.3 4916.7 4916.7 3610.7 3679.8 3692.0 3794.1 3794.4 3746.1 3772.7 3799.0 3816.9 3831.0 3756.1 3764.5 3769.8 3772.3 3782.8 3683.1 3754.2 3764.8 3775.6 3783.3 3258.3 3266.1 3272.7 3282.1 3288.9 4657.4 4751.1 4782.2 4834.6 4842.3 4173.6 4177.2 4182.6 4183.7 4194.4 4957.1 5125.3 5135.2 5137.6 5152.1 3396.0 3402.9 3413.3 3454.8 3473.5 5253.9 5280.1 5319.2 5383.4 5412.2 3497.1 3498.4 3505.1 3513.9 3515.1 3538.9 3539.1 3540.7 3547.4 3549.5 4055.9 4123.6 4131.4 4198.4 4228.2 5214.4 5224.8 5229.1 5232.2 5236.6 1268.3 1294.0 1294.0 1294.5 1300.9 817.9 822.3 836.0 836.8 837.0 4987.4 4989.9 4999.7 5016.2 5027.1 5424.3 5425.0 5429.0 5451.3 5525.6 4987.9 4994.3 5002.5 5008.4 5111.0 2908.7 2989.9 3001.4 3020.8 3030.8 5459.0 5459.2 5486.2 5488.5 5489.6 5541.1 5541.9 5542.4 5570.9 5651.1 5445.3 5471.1 5477.4 5488.0 5539.3 5255.5 5304.1 5396.4 5431.3 5433.8 5094.6 5186.3 5305.4 5319.5 5322.9 5357.4 5382.8 5457.6 5488.4 5489.9 3511.2 3545.8 3577.1 3578.1 3586.6 5345.3 5438.0 5456.7 5461.8 5480.2 5134.6 5222.5 5264.9 5274.7 5294.7 5259.8 5272.4 5280.2 5281.3 5365.9 5131.0 5136.5 5137.8 5149.9 5163.5 5087.4 5277.7 5280.1 5291.6 5294.3 5177.8 5179.8 5181.3 5189.4 5219.4 22:48:09 INFO - 2015-11-04 22:48:09,829 DEBUG : BROWSER_OUTPUT: 22:48:09 INFO - 2015-11-04 22:48:09,829 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10819.93 Median:3185.02 stddev:12655.49 (397.3%) stddev-sans-first:12667.72 22:48:09 INFO - 2015-11-04 22:48:09,833 DEBUG : BROWSER_OUTPUT: Values: 599.3 613.8 619.6 623.4 632.2 10947.7 10997.6 11204.8 11376.7 11381.6 11270.1 11425.0 11625.4 11627.6 11675.8 582.0 583.2 674.4 714.9 742.0 571.8 716.0 726.6 737.2 739.7 748.5 774.5 777.8 785.8 787.9 609.1 609.3 610.1 770.1 782.8 557.4 571.6 572.4 572.4 576.5 11425.8 11501.1 11512.1 11673.6 11716.9 9526.8 9549.9 9601.3 9742.3 9923.3 7658.8 7707.9 7711.9 7818.1 7940.0 2617.6 2640.9 2701.1 2754.1 2769.0 39300.8 40114.0 40258.4 40430.8 40710.2 7269.2 7326.7 7328.7 7423.0 7494.6 15895.9 15952.8 16117.5 16129.4 16267.2 5793.5 5888.1 5903.5 5947.1 5952.9 3167.4 3174.4 3194.2 3228.0 3340.3 2191.0 2241.9 2246.2 2269.1 2273.6 348.9 351.6 353.7 359.5 360.6 334.9 433.4 454.4 482.9 506.6 6201.0 6276.5 6375.6 6416.6 6464.6 334.3 419.4 476.5 492.8 504.7 2955.0 3076.8 3285.5 3312.0 3383.5 39638.8 39812.4 40222.2 40328.4 40857.4 39659.0 40063.0 40107.2 40884.0 41398.0 37691.6 37905.8 38337.8 38831.0 38971.0 6443.8 6448.5 6626.3 6741.3 6770.4 27685.0 28321.6 28705.0 28812.7 29075.7 34276.7 34890.8 36845.0 38899.2 39194.0 6085.5 6124.8 6182.1 6304.7 6316.1 8746.4 8759.4 9005.7 9158.6 9639.4 8354.2 8358.0 8389.9 8431.6 8514.1 8157.0 8176.9 8223.8 8229.4 8241.1 7952.3 8001.0 8002.4 8106.4 8265.0 7178.2 7203.7 7436.2 7611.0 7682.8 6977.2 6980.4 7162.1 7194.4 7194.5 22:48:09 INFO - 2015-11-04 22:48:09,833 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:48:09 INFO - 2015-11-04 22:48:09,833 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-04 22:48:10,518 INFO : Browser exited with error code: 0 22:48:10 INFO - 2015-11-04 22:48:10,551 INFO : Completed test dromaeo_css (00:18:36) 22:48:10 INFO - 2015-11-04 22:48:10,551 INFO : Starting test kraken 22:48:10 INFO - 2015-11-04 22:48:10,551 DEBUG : operating with platform_type : mac_ 22:48:10 INFO - 2015-11-04 22:48:10,552 INFO : Initialising browser for kraken test... 22:48:10 INFO - 2015-11-04 22:48:10,567 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpfWdN5x/profile http://localhost:49270/getInfo.html 22:48:13 INFO - 2015-11-04 22:48:13,121 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:48:13 INFO - 2015-11-04 22:48:13,121 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:48:13 INFO - 2015-11-04 22:48:13,121 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:48:13 INFO - 2015-11-04 22:48:13,121 DEBUG : BROWSER_OUTPUT: __metrics 22:48:13 INFO - 2015-11-04 22:48:13,142 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:48:13 INFO - 2015-11-04 22:48:13,929 INFO : Browser initialized. 22:48:13 INFO - 2015-11-04 22:48:13,930 INFO : Running cycle 1/1 for kraken test... 22:48:13 INFO - 2015-11-04 22:48:13,930 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpfWdN5x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:48:26 INFO - 2015-11-04 22:48:26,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 221241344 22:48:26 INFO - 2015-11-04 22:48:26,060 DEBUG : BROWSER_OUTPUT: 22:48:29 INFO - 2015-11-04 22:48:29,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 22:48:29 INFO - 2015-11-04 22:48:29,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 277860352 22:48:29 INFO - 2015-11-04 22:48:29,669 DEBUG : BROWSER_OUTPUT: 22:48:32 INFO - 2015-11-04 22:48:32,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 22:48:33 INFO - 2015-11-04 22:48:33,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 290545664 22:48:33 INFO - 2015-11-04 22:48:33,384 DEBUG : BROWSER_OUTPUT: 22:48:36 INFO - 2015-11-04 22:48:36,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 22:48:37 INFO - 2015-11-04 22:48:37,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 271372288 22:48:37 INFO - 2015-11-04 22:48:37,434 DEBUG : BROWSER_OUTPUT: 22:48:39 INFO - 2015-11-04 22:48:39,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 22:48:40 INFO - 2015-11-04 22:48:40,398 DEBUG : BROWSER_OUTPUT: RSS: Main: 274194432 22:48:40 INFO - 2015-11-04 22:48:40,398 DEBUG : BROWSER_OUTPUT: 22:48:42 INFO - 2015-11-04 22:48:42,921 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:48:43 INFO - 2015-11-04 22:48:43,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 274735104 22:48:43 INFO - 2015-11-04 22:48:43,505 DEBUG : BROWSER_OUTPUT: 22:48:47 INFO - 2015-11-04 22:48:47,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 22:48:47 INFO - 2015-11-04 22:48:47,742 DEBUG : BROWSER_OUTPUT: RSS: Main: 270815232 22:48:47 INFO - 2015-11-04 22:48:47,742 DEBUG : BROWSER_OUTPUT: 22:48:51 INFO - 2015-11-04 22:48:51,483 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 22:48:52 INFO - 2015-11-04 22:48:52,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 271572992 22:48:52 INFO - 2015-11-04 22:48:52,092 DEBUG : BROWSER_OUTPUT: 22:48:55 INFO - 2015-11-04 22:48:55,505 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 22:48:56 INFO - 2015-11-04 22:48:56,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 274038784 22:48:56 INFO - 2015-11-04 22:48:56,093 DEBUG : BROWSER_OUTPUT: 22:48:57 INFO - 2015-11-04 22:48:57,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:48:58 INFO - 2015-11-04 22:48:58,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 311296000 22:48:58 INFO - 2015-11-04 22:48:58,413 DEBUG : BROWSER_OUTPUT: 22:49:00 INFO - 2015-11-04 22:49:00,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:49:01 INFO - 2015-11-04 22:49:01,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 311209984 22:49:01 INFO - 2015-11-04 22:49:01,118 DEBUG : BROWSER_OUTPUT: 22:49:03 INFO - 2015-11-04 22:49:03,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:49:04 INFO - 2015-11-04 22:49:04,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 318427136 22:49:04 INFO - 2015-11-04 22:49:04,171 DEBUG : BROWSER_OUTPUT: 22:49:07 INFO - 2015-11-04 22:49:07,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:49:07 INFO - 2015-11-04 22:49:07,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 320245760 22:49:07 INFO - 2015-11-04 22:49:07,836 DEBUG : BROWSER_OUTPUT: 22:49:10 INFO - 2015-11-04 22:49:10,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:49:11 INFO - 2015-11-04 22:49:11,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 318869504 22:49:11 INFO - 2015-11-04 22:49:11,498 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,468 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 22:49:13 INFO - 2015-11-04 22:49:13,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 379080704 22:49:13 INFO - 2015-11-04 22:49:13,726 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,726 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:49:13 INFO - 2015-11-04 22:49:13,726 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:49:13 INFO - 2015-11-04 22:49:13,727 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:49:13 INFO - 2015-11-04 22:49:13,727 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:49:13 INFO - 2015-11-04 22:49:13,727 DEBUG : BROWSER_OUTPUT: |0;ai-astar;127;134;125;140;140;135;131;134;123;131 22:49:13 INFO - 2015-11-04 22:49:13,727 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;188;162;191;205;163;187;179;153;204;164 22:49:13 INFO - 2015-11-04 22:49:13,727 DEBUG : BROWSER_OUTPUT: |2;audio-dft;192;197;206;204;195;198;198;197;206;204 22:49:13 INFO - 2015-11-04 22:49:13,727 DEBUG : BROWSER_OUTPUT: |3;audio-fft;87;101;102;146;83;90;88;91;144;81 22:49:13 INFO - 2015-11-04 22:49:13,728 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;119;121;171;116;115;112;150;109;108;151 22:49:13 INFO - 2015-11-04 22:49:13,728 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;140;141;149;149;151;148;150;143;149;154 22:49:13 INFO - 2015-11-04 22:49:13,728 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;155;161;162;154;154;162;162;157;154;154 22:49:13 INFO - 2015-11-04 22:49:13,728 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;122;128;129;129;131;127;129;124;130;130 22:49:13 INFO - 2015-11-04 22:49:13,728 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;68;69;69;69;73;74;83;71;72 22:49:13 INFO - 2015-11-04 22:49:13,729 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;78;85;86;86;86;82;82;82;82 22:49:13 INFO - 2015-11-04 22:49:13,729 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;104;107;112;114;111;113;112;112;106;108 22:49:13 INFO - 2015-11-04 22:49:13,729 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;172;157;165;158;166;160;166;173;164;158 22:49:13 INFO - 2015-11-04 22:49:13,729 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;188;183;191;192;192;176;185;183;187;190 22:49:13 INFO - 2015-11-04 22:49:13,729 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;84;85;84;87;90;89;90;89;89 22:49:13 INFO - 2015-11-04 22:49:13,729 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:49:13 INFO - 2015-11-04 22:49:13,730 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:49:13 INFO - 2015-11-04 22:49:13,730 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1008 22:49:13 INFO - 2015-11-04 22:49:13,730 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:49:13 INFO - 2015-11-04 22:49:13,730 DEBUG : BROWSER_OUTPUT: __startTimestamp1446706153721__endTimestamp 22:49:13 INFO - 2015-11-04 22:49:13,731 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,731 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:49:13 INFO - 2015-11-04 22:49:13,731 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:49:13 INFO - 2015-11-04 22:49:13,731 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,731 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:132.00 Median:134.00 stddev:5.79 (4.3%) stddev-sans-first:5.85 22:49:13 INFO - 2015-11-04 22:49:13,732 DEBUG : BROWSER_OUTPUT: Values: 127.0 134.0 125.0 140.0 140.0 135.0 131.0 134.0 123.0 131.0 22:49:13 INFO - 2015-11-04 22:49:13,732 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,732 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:179.60 Median:187.50 stddev:18.36 (9.8%) stddev-sans-first:19.22 22:49:13 INFO - 2015-11-04 22:49:13,732 DEBUG : BROWSER_OUTPUT: Values: 188.0 162.0 191.0 205.0 163.0 187.0 179.0 153.0 204.0 164.0 22:49:13 INFO - 2015-11-04 22:49:13,732 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,733 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:199.70 Median:201.00 stddev:4.92 (2.4%) stddev-sans-first:4.36 22:49:13 INFO - 2015-11-04 22:49:13,733 DEBUG : BROWSER_OUTPUT: Values: 192.0 197.0 206.0 204.0 195.0 198.0 198.0 197.0 206.0 204.0 22:49:13 INFO - 2015-11-04 22:49:13,733 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,733 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:101.30 Median:85.00 stddev:24.00 (28.2%) stddev-sans-first:24.89 22:49:13 INFO - 2015-11-04 22:49:13,733 DEBUG : BROWSER_OUTPUT: Values: 87.0 101.0 102.0 146.0 83.0 90.0 88.0 91.0 144.0 81.0 22:49:13 INFO - 2015-11-04 22:49:13,734 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,734 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:127.20 Median:120.00 stddev:21.90 (18.2%) stddev-sans-first:23.02 22:49:13 INFO - 2015-11-04 22:49:13,734 DEBUG : BROWSER_OUTPUT: Values: 119.0 121.0 171.0 116.0 115.0 112.0 150.0 109.0 108.0 151.0 22:49:13 INFO - 2015-11-04 22:49:13,734 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,734 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:147.40 Median:149.00 stddev:4.55 (3.1%) stddev-sans-first:3.96 22:49:13 INFO - 2015-11-04 22:49:13,735 DEBUG : BROWSER_OUTPUT: Values: 140.0 141.0 149.0 149.0 151.0 148.0 150.0 143.0 149.0 154.0 22:49:13 INFO - 2015-11-04 22:49:13,735 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,735 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:157.50 Median:159.00 stddev:3.78 (2.4%) stddev-sans-first:3.90 22:49:13 INFO - 2015-11-04 22:49:13,735 DEBUG : BROWSER_OUTPUT: Values: 155.0 161.0 162.0 154.0 154.0 162.0 162.0 157.0 154.0 154.0 22:49:13 INFO - 2015-11-04 22:49:13,736 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,736 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:127.90 Median:129.00 stddev:2.85 (2.2%) stddev-sans-first:2.07 22:49:13 INFO - 2015-11-04 22:49:13,736 DEBUG : BROWSER_OUTPUT: Values: 122.0 128.0 129.0 129.0 131.0 127.0 129.0 124.0 130.0 130.0 22:49:13 INFO - 2015-11-04 22:49:13,736 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,736 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.50 stddev:5.03 (7.0%) stddev-sans-first:4.61 22:49:13 INFO - 2015-11-04 22:49:13,736 DEBUG : BROWSER_OUTPUT: Values: 64.0 68.0 69.0 69.0 69.0 73.0 74.0 83.0 71.0 72.0 22:49:13 INFO - 2015-11-04 22:49:13,736 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,737 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:82.30 Median:83.50 stddev:3.89 (4.7%) stddev-sans-first:2.73 22:49:13 INFO - 2015-11-04 22:49:13,737 DEBUG : BROWSER_OUTPUT: Values: 74.0 78.0 85.0 86.0 86.0 86.0 82.0 82.0 82.0 82.0 22:49:13 INFO - 2015-11-04 22:49:13,737 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,737 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:109.90 Median:112.00 stddev:3.38 (3.0%) stddev-sans-first:2.83 22:49:13 INFO - 2015-11-04 22:49:13,737 DEBUG : BROWSER_OUTPUT: Values: 104.0 107.0 112.0 114.0 111.0 113.0 112.0 112.0 106.0 108.0 22:49:13 INFO - 2015-11-04 22:49:13,737 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,739 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:163.90 Median:165.50 stddev:5.69 (3.4%) stddev-sans-first:5.22 22:49:13 INFO - 2015-11-04 22:49:13,739 DEBUG : BROWSER_OUTPUT: Values: 172.0 157.0 165.0 158.0 166.0 160.0 166.0 173.0 164.0 158.0 22:49:13 INFO - 2015-11-04 22:49:13,740 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,740 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.70 Median:189.00 stddev:5.08 (2.7%) stddev-sans-first:5.36 22:49:13 INFO - 2015-11-04 22:49:13,740 DEBUG : BROWSER_OUTPUT: Values: 188.0 183.0 191.0 192.0 192.0 176.0 185.0 183.0 187.0 190.0 22:49:13 INFO - 2015-11-04 22:49:13,740 DEBUG : BROWSER_OUTPUT: 22:49:13 INFO - 2015-11-04 22:49:13,740 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.70 Median:89.00 stddev:3.33 (3.7%) stddev-sans-first:2.51 22:49:13 INFO - 2015-11-04 22:49:13,740 DEBUG : BROWSER_OUTPUT: Values: 80.0 84.0 85.0 84.0 87.0 90.0 89.0 90.0 89.0 89.0 22:49:13 INFO - 2015-11-04 22:49:13,740 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:49:13 INFO - 2015-11-04 22:49:13,741 DEBUG : BROWSER_OUTPUT: 22:49:14 INFO - 2015-11-04 22:49:14,466 INFO : Browser exited with error code: 0 22:49:14 INFO - 2015-11-04 22:49:14,524 INFO : Completed test kraken (00:01:03) 22:49:14 INFO - 2015-11-04 22:49:14,524 INFO : Starting test v8_7 22:49:14 INFO - 2015-11-04 22:49:14,524 DEBUG : operating with platform_type : mac_ 22:49:14 INFO - 2015-11-04 22:49:14,525 INFO : Initialising browser for v8_7 test... 22:49:14 INFO - 2015-11-04 22:49:14,540 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpP0PYXl/profile http://localhost:49270/getInfo.html 22:49:17 INFO - 2015-11-04 22:49:17,254 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:49:17 INFO - 2015-11-04 22:49:17,254 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:49:17 INFO - 2015-11-04 22:49:17,255 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:49:17 INFO - 2015-11-04 22:49:17,255 DEBUG : BROWSER_OUTPUT: __metrics 22:49:17 INFO - 2015-11-04 22:49:17,272 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:49:18 INFO - 2015-11-04 22:49:18,055 INFO : Browser initialized. 22:49:18 INFO - 2015-11-04 22:49:18,055 INFO : Running cycle 1/1 for v8_7 test... 22:49:18 INFO - 2015-11-04 22:49:18,055 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/tmpP0PYXl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:49:30 INFO - 2015-11-04 22:49:30,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 221446144 22:49:30 INFO - 2015-11-04 22:49:30,177 DEBUG : BROWSER_OUTPUT: 22:49:52 INFO - 2015-11-04 22:49:52,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49270/tests/v8_7/run.html (next: http://localhost:49270/tests/v8_7/run.html) 22:49:53 INFO - 2015-11-04 22:49:53,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 313110528 22:49:53 INFO - 2015-11-04 22:49:53,062 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,062 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:49:53 INFO - 2015-11-04 22:49:53,062 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:49:53 INFO - 2015-11-04 22:49:53,062 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:49:53 INFO - 2015-11-04 22:49:53,062 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: |0;Richards;201.61290322580646 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;244.43901246638964 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: |2;Encrypt;398.5651654045436 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6896.551724137931 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2549.618320610687 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: |5;Earley;973.7098344693281 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: |6;Boyer;16683.333333333332 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: |7;RegExp;36727.27272727273 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: |8;Splay;772.2007722007722 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7027.972027972028 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: __startTimestamp1446706193059__endTimestamp 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,063 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:201.61 Median:201.61 stddev:0.00 (0.0%) 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: Values: 201.6 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:244.44 Median:244.44 stddev:0.00 (0.0%) 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: Values: 244.4 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:398.57 Median:398.57 stddev:0.00 (0.0%) 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: Values: 398.6 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,064 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6896.55 Median:6896.55 stddev:0.00 (0.0%) 22:49:53 INFO - 2015-11-04 22:49:53,065 DEBUG : BROWSER_OUTPUT: Values: 6896.6 22:49:53 INFO - 2015-11-04 22:49:53,065 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,065 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2549.62 Median:2549.62 stddev:0.00 (0.0%) 22:49:53 INFO - 2015-11-04 22:49:53,065 DEBUG : BROWSER_OUTPUT: Values: 2549.6 22:49:53 INFO - 2015-11-04 22:49:53,065 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,065 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:973.71 Median:973.71 stddev:0.00 (0.0%) 22:49:53 INFO - 2015-11-04 22:49:53,065 DEBUG : BROWSER_OUTPUT: Values: 973.7 22:49:53 INFO - 2015-11-04 22:49:53,065 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,065 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16683.33 Median:16683.33 stddev:0.00 (0.0%) 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: Values: 16683.3 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:36727.27 Median:36727.27 stddev:0.00 (0.0%) 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: Values: 36727.3 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:772.20 Median:772.20 stddev:0.00 (0.0%) 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: Values: 772.2 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7027.97 Median:7027.97 stddev:0.00 (0.0%) 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: Values: 7028.0 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:49:53 INFO - 2015-11-04 22:49:53,066 DEBUG : BROWSER_OUTPUT: 22:49:53 INFO - 2015-11-04 22:49:53,755 INFO : Browser exited with error code: 0 22:49:53 INFO - 2015-11-04 22:49:53,779 INFO : Completed test v8_7 (00:00:39) 22:49:54 INFO - 2015-11-04 22:49:54,057 INFO : Completed test suite (00:20:19) 22:49:54 INFO - 2015-11-04 22:49:54,057 DEBUG : Working with test: dromaeo_css 22:49:54 INFO - 2015-11-04 22:49:54,057 DEBUG : Generating results file: dromaeo_css 22:49:54 INFO - 2015-11-04 22:49:54,058 DEBUG : Working with test: kraken 22:49:54 INFO - 2015-11-04 22:49:54,058 DEBUG : Generating results file: kraken 22:49:54 INFO - 2015-11-04 22:49:54,058 INFO : javascript benchmark 22:49:54 INFO - 2015-11-04 22:49:54,059 DEBUG : Working with test: v8_7 22:49:54 INFO - 2015-11-04 22:49:54,059 DEBUG : Generating results file: v8_7 22:49:54 INFO - 2015-11-04 22:49:54,059 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:54 INFO - 2015-11-04 22:49:54,199 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 22:49:54 INFO - 2015-11-04 22:49:54,199 DEBUG : process_Request line: dromaeo_css 5323.22 graph.html#tests=[[72,64,55]] 22:49:54 INFO - 2015-11-04 22:49:54,199 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:54 INFO - 2015-11-04 22:49:54,232 DEBUG : process_Request line: kraken 1873.30 graph.html#tests=[[232,64,55]] 22:49:54 INFO - 2015-11-04 22:49:54,232 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:49:54 INFO - 2015-11-04 22:49:54,271 DEBUG : process_Request line: v8_7 14968.71 graph.html#tests=[[230,64,55]] 22:49:54 INFO - 2015-11-04 22:49:54,272 INFO : javascript benchmark 22:49:54 INFO - 2015-11-04 22:49:54,274 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [272.7095643140057, 274.2007049450851, 275.1923105684817, 277.79165625780666, 283.8779324890297, 13905.652358691024, 14226.857731422682, 14371.209583472917, 14589.635259118528, 15562.688746225069, 11821.468033938472, 12135.696607584814, 12488.562900298492, 12519.874801251985, 15154.6969060619, 4249.362595610668, 4407.493138289105, 4438.933415998747, 4486.97756511217, 4515.706479078865, 3658.3414985302634, 3795.582485926546, 3873.2640798248385, 4355.085432059255, 4443.822247110112, 2708.6614173228345, 2784.470950519405, 2789.511835428792, 3728.757630753992, 3804.4673745675627, 3760.680342170905, 3838.0788610733503, 3841.78870162141, 3870.8838734838, 3925.1953349563555, 3303.801771893694, 3308.503724441353, 3312.1719570107475, 3316.817575033372, 3319.0872510059685, 10442.63450779219, 10667.093297069758, 10668.093212076983, 10681.465926703711, 10698.839517407245, 1287.748888966652, 1309.508934149694, 1348.9123206991515, 1518.5064853922408, 1584.6672198838141, 7521.24787521249, 7694.1847899163495, 7701.961490192569, 7796.961015194945, 7956.482828616122, 1223.5962132496343, 1234.9506019759199, 1248.5692436109528, 1268.0362924177691, 1272.694553307209, 45664.0, 46295.30557041647, 46749.532504674855, 48069.5193048072, 48437.75781121107, 5124.308978037238, 5132.30713853625, 5159.226116082617, 5233.058049551041, 5290.867728306823, 5888.205092312483, 5900.085486749561, 6027.939720602825, 6028.758849646053, 6034.517238620988, 4350.630196433339, 4394.604485596312, 4438.068005718771, 4439.156560253606, 4452.577005184502, 4699.224627936421, 4734.431868175841, 4740.976295118502, 4832.685875418087, 4844.442889067803, 2317.953640927172, 2333.661619065226, 2343.847649902751, 2346.979064107119, 2386.8687222202598, 820.7742870710603, 824.1387749801472, 827.9172082791673, 851.3870013590329, 892.4199270474244, 335.2640953107905, 345.481777333999, 347.633246924492, 354.96982756465474, 362.7859562857926, 7804.219578042151, 9105.635774569075, 9327.766805829908, 9416.670416535388, 9514.0, 320.8299601211362, 366.71945961339594, 369.5620689482971, 378.54763557548466, 379.07127537533154, 4928.285398617252, 5176.301199338041, 5193.844184674465, 5224.817131400383, 5229.790808367698, 475177.0, 478950.0, 481193.0, 484450.0, 490170.0, 56341.43658563444, 56378.71810641002, 56392.0, 56603.71698141565, 56837.43162568404, 397.5904818037426, 402.3522129371709, 402.4607026584391, 402.65774092022133, 409.5924555067667, 8685.0, 8807.163319484638, 8812.42719223274, 8892.688755893512, 8931.285497160341, 28095.71904280931, 28321.57517637196, 28638.57042144411, 28993.7100628991, 29042.27394315159, 37793.433098502996, 37853.43219851649, 38025.61974380331, 38296.808515957244, 38623.0, 4972.751362431936, 5034.263179203169, 5057.5448209659835, 5060.266261392151, 5151.665141765773, 9534.666286679932, 9589.712308630753, 9683.128518433376, 9699.466529340672, 9838.75403114928, 8071.798205044686, 8186.754397368089, 8453.323734101381, 8509.74470765878, 8545.487270763773, 7686.192949740421, 8105.959470202847, 8199.139090395423, 8362.372822038249, 8533.658653653783, 7937.801554960941, 8349.457285276438, 8661.826763464569, 8678.78303042429, 8780.25367843715, 4353.3469979503325, 4574.290984897346, 4577.176108300538, 4754.4770075291, 4998.4501704813165, 7827.178146294785, 8197.672093116447, 8225.177482251727, 8228.094909559824, 8234.752957411287], "dojo.html": [2563.8461692298465, 2627.9080232191864, 2651.1781347782176, 2655.4689062187567, 2656.25624825049, 4151.128263064753, 4314.417553630259, 4335.86992390228, 4385.627221686156, 4466.330050492424, 4310.5904939030825, 4326.06989497258, 4352.325389564622, 4409.228385032622, 4468.0170362520275, 3953.7430067045693, 3992.021954621122, 4035.9506528302704, 4059.8985025374304, 4073.5111786585653, 4049.9797501012454, 4090.14107037521, 4112.712110152291, 4123.36087906375, 4165.375193720935, 3872.5740168581715, 3978.1844721831953, 3986.86045988389, 4044.1102957349335, 4166.333386658135, 4020.9396859047138, 4076.510818701745, 4090.0388408723925, 4111.671066314688, 4113.609207125318, 4010.83956641734, 4024.0342317843506, 4059.6955228357697, 4060.5127384714024, 4116.897077573085, 4191.874243772661, 4249.915001699948, 4303.053328267776, 4311.353297005474, 4383.846565370229, 4596.954030459686, 4597.080583883203, 4620.052889157748, 4708.0819240248165, 4721.952780472186, 4641.141388843075, 4641.791119399635, 4678.228092364756, 4732.0, 4785.641076919245, 4301.698881078357, 4348.152110338517, 4349.695521313541, 4354.716943398669, 4383.057642606823, 4717.693349932243, 4796.232602783608, 4843.733594652257, 4885.169521181337, 4898.730569818623, 4629.1436084324505, 4638.83764068256, 4648.6745927785405, 4651.116287905287, 4726.078414709167, 4483.21543729846, 4555.33947577606, 4584.862454126382, 4707.129181101507, 4839.032193561302, 4641.048585040058, 4646.8141274348645, 4647.535246475393, 4697.953020469751, 4709.458412282632, 4630.3748993886065, 4647.674662773574, 4656.8602941911795, 4682.227432473672, 4696.647751418657, 3530.876419325363, 3612.5845527764645, 3613.8012409317216, 3626.5829429615405, 3659.908502287411, 3312.519684645761, 3322.8172450515453, 3341.7827841190247, 3350.748693847971, 3356.0938546592283, 4389.3415987601475, 4401.0, 4404.273294906368, 4407.537208593116, 4527.0, 4477.529859364719, 4605.240135377692, 4619.307103934437, 4652.418447694038, 4718.079974404958, 4380.934285985712, 4384.8246070157475, 4386.0, 4433.290673492225, 4470.307102399133, 4118.897027574335, 4130.545639979599, 4136.503619565671, 4167.604077612622, 4242.915141697149, 4599.241125214369, 4626.606738427136, 4670.276107203457, 4733.219018861849, 4738.597219236334, 4716.551927566876, 4740.549647783455, 4751.501092385388, 4765.0946320199055, 4790.257510085942, 4749.35883655702, 4766.928496072493, 4770.236762118045, 4784.6889952153, 4789.425268967746, 4434.689571730077, 4525.841595544141, 4538.387317712199, 4613.469451013177, 4690.788914498788, 4674.298855171752, 4688.2733176357715, 4700.858974230779, 4732.432108147044, 4770.666053376231, 4551.0, 4560.794764235551, 4576.427946506687, 4593.908121837611, 4666.766661666971, 4224.725392849455, 4248.617624413818, 4375.256206444848, 4501.977490112659, 4539.364488971612, 4444.933326000178, 4496.4154659894, 4499.347594598699, 4502.099580083931, 4567.497575266651, 4588.3805686231935, 4592.586667199968, 4606.493285738499, 4609.377734005866, 4639.5128511507155, 4283.336082907154, 4385.386045953633, 4391.341298805205, 4402.405675233803, 4493.977530112328], "mootools.html": [1087.9619213327535, 1143.502576379275, 1171.6719318590797, 1308.5093090091214, 1458.883289336853, 5259.447757985409, 5536.916946245805, 5628.915566266504, 5725.7995970141055, 5784.421557844214, 5750.971245143779, 5770.596058275912, 5847.298324201101, 5874.148248503964, 5897.587168898179, 1746.7816522934634, 1757.3585641240918, 1773.184335205807, 1773.6807374672553, 1775.1301862087614, 1710.2816816936854, 1767.19592585374, 1768.796588392332, 1775.3874913154941, 1794.156746329223, 1725.6031112844053, 1748.3006797281062, 1756.9121543922752, 1757.2531674038482, 1761.3130878957218, 1709.265016043101, 1728.5764987578061, 1730.9134543272785, 1732.5928406824387, 1735.7309617009385, 1711.9657606847793, 1734.4363081998401, 1740.721484562464, 1742.9389971350943, 1743.2329774899003, 5394.622376433651, 5835.095560188178, 5843.737031833535, 5846.561507886926, 5853.678047707374, 3353.832308384571, 3431.9485207721905, 3531.5055892175114, 3676.1728611062563, 3702.315071711715, 2233.9776602234097, 2290.6564015397657, 2319.0723710515927, 2322.7677232276637, 2324.3840382298704, 743.9218882017365, 762.4015148108708, 763.2939530933864, 777.1412589089032, 780.2041917244379, 7332.816679582999, 7549.396048316176, 7551.811204719871, 7559.28186822251, 7564.848703025964, 3195.2171717929255, 3226.274088330154, 3278.2951665392056, 3336.199312165063, 3349.7152742016715, 6790.796276111724, 6791.151106111736, 6797.864042719118, 6798.286179951034, 6799.932000680029, 3733.5519737631657, 3739.794311312904, 3742.1206016586625, 3743.7753734776, 3751.0622344413896, 3396.3207358528393, 3400.795952242873, 3404.5403870477166, 3405.540252065989, 3409.641987591267, 2755.145904769528, 2802.957955630667, 2815.577663350473, 2833.4616422879585, 2835.8723857426467, 873.8121303919688, 874.5233847553098, 889.2707979456783, 903.9412438191497, 905.4929239625831, 1058.7882423515173, 1065.872095348563, 1076.079951641351, 1076.3541874875168, 1100.7138144082596, 5352.464753524694, 5580.386157522669, 5627.352854421794, 5651.124075768263, 5658.462446067617, 374.9894035574156, 379.37403284580114, 961.4904100826573, 990.1435258501344, 1007.2043085962155, 4393.51671316155, 4541.137183935108, 4546.227141385973, 4551.931721024187, 4553.977230113828, 6427.100205971168, 6549.279579246279, 6555.868882622321, 6560.671966401661, 6822.522423430312, 6719.865602687919, 6740.662966851638, 6754.662266886636, 6764.255931847493, 6775.627340496221, 5446.319210098738, 5473.233747275384, 5532.695701736363, 5542.334919809648, 5545.085060964896, 5488.560915126701, 5542.61201715876, 5556.972215138899, 5560.4161563035295, 5568.610197286151, 5907.852303692442, 6150.630962142286, 6187.257529096537, 6192.411720886508, 6276.0, 6226.564140510302, 6242.250929888442, 6249.0626406039455, 6255.812325630239, 6258.7809426671665, 4969.155243608668, 5055.87360315995, 5059.772310245974, 5060.418051924076, 5066.341375621146, 5634.577406694596, 5660.405657406078, 5666.660000399989, 5672.716364181857, 5741.91387129185, 5227.686338819531, 5299.152135658276, 5314.707691077027, 5373.865653358697, 5392.056390131633, 5205.427402985744, 5221.608379371638, 5274.97362513185, 5282.630215885005, 5302.787888484571, 5347.919781203207, 5373.032854086302, 5383.892322153613, 5384.6499977501335, 5396.83809485716, 4861.829835955725, 4894.241392584155, 4895.020995800783, 4927.236278376714, 4929.309896614549, 4907.288443175791, 4975.601951843916, 5003.299538064746, 5009.8747531310555, 5016.598672106295], "ext.html": [451.81701410928576, 462.18885855323924, 463.3374274787053, 473.9004808990112, 491.9398695810525, 25940.61089083663, 27336.17991460257, 32301.353972920526, 32966.0, 33442.8327858361, 35190.648093519056, 35237.295254094905, 35264.29471410577, 35300.470492942564, 35828.82085589568, 6729.596224226538, 7584.0, 7620.733274335399, 7647.770566882975, 7768.145503994556, 6828.531865648884, 9037.141471560224, 9199.95400022999, 9226.538673066354, 9339.15947564719, 8840.38117331787, 9072.59173337198, 9108.681196158135, 9119.635214591408, 9154.26765858733, 6894.13823272091, 7064.611446370448, 7096.219415864251, 8938.240249578761, 9063.909360906406, 8688.869666955, 8900.599473023665, 8914.687985920462, 8931.285497160277, 9085.227755640779, 30160.8491957541, 30505.847470762725, 30600.8469957651, 31054.37891242185, 31091.689083109104, 2435.232901635979, 2607.3351295419548, 2656.787457003435, 2742.204760619418, 2965.584818125464, 22330.88834555833, 22632.321030369116, 22772.0, 23013.53972920532, 23284.76715232843, 1912.6270377276437, 1914.9329773458, 1941.5049162463622, 1945.1246938877562, 1961.431184956361, 215380.0, 216229.0, 217360.0, 217633.0, 218726.90636546875, 49806.50193498019, 49811.0, 49880.750596246784, 49921.251181232314, 49931.25103123456, 47500.76249618799, 49102.26346604804, 49199.75400122976, 52442.0, 52863.20705189425, 13559.864401356057, 13893.58319250424, 13992.23042732639, 14127.78808317876, 14163.079399838978, 10476.266661333786, 10527.578896844041, 10576.259661823598, 10692.0, 10771.299865508718, 16265.349386024664, 16269.918650406673, 16287.0, 16358.754618680729, 16380.672386552202, 7133.678984445609, 7135.357817796424, 7211.963940180265, 7273.599952002691, 7275.454340924346, 748.7341993592305, 765.1239330966013, 810.691937063912, 899.5547204133995, 906.5376657904384, 21265.577277794062, 21660.35018949434, 21682.457938551346, 21709.0, 21726.13095476195, 863.6631713631689, 879.4547380624055, 947.0, 954.346272803132, 1021.1779517488345, 11208.383538905438, 11427.542898284142, 11505.397840863721, 11607.825882611767, 11652.592159274385, 235220.0, 235544.0, 237935.0, 238936.0, 239525.0, 44557.554424455986, 44814.55185448169, 44964.0, 45763.0, 45786.0, 1019.8470229465491, 1048.6067724603427, 1049.296971029397, 1153.400231879418, 1164.6564263542107, 17753.381034753853, 21981.780182197974, 23152.53694926126, 24154.51690966206, 24179.879100604383, 42343.0, 42422.0, 42707.786461067495, 43174.78412607917, 43234.783826081926, 227658.0, 231047.0, 232435.0, 281167.0, 284005.0, 25335.746642534075, 26504.602430963165, 26811.865940670174, 26925.192244232705, 26946.865265673547, 28270.575941360486, 28528.144155675363, 28772.0, 28869.711302886702, 28911.56632650554, 26419.735802641728, 27111.499562991634, 27874.16377508678, 28391.716082839732, 28579.28551786222, 27972.30069248285, 28111.00627517928, 28590.285242869093, 28669.0, 28763.0, 28961.7103828959, 29276.56085158682, 29302.70697293085, 29775.404491910474, 29797.85101074481, 23927.28218153458, 25780.613290800276, 25847.870760646078, 25937.481250375266, 26407.339816503973, 19379.51551211231, 19380.0, 19439.125239364545, 19539.902300488975, 19584.706229406285], "prototype.html": [251.71556141560035, 258.21888786421084, 258.9925191006983, 260.9399838037251, 265.34327539340137, 4777.665563410563, 4905.215165573509, 4923.138450771115, 4928.753562321887, 4930.802767889285, 4801.879953001177, 4886.584640305578, 4916.287138364935, 4916.729579873106, 4916.729579873106, 3610.729195310349, 3679.816009199543, 3692.02161427222, 3794.1273507093383, 3794.4118661607495, 3746.0822098585886, 3772.6604605585494, 3798.9810050949704, 3816.9427458588143, 3830.9808450957707, 3756.136088699601, 3764.454154147647, 3769.8115094245313, 3772.320982223199, 3782.7919464429447, 3683.0976410779394, 3754.2491501699633, 3764.849406023756, 3775.565809931838, 3783.3379158647126, 3258.25060236147, 3266.0528446750413, 3272.7381809455187, 3282.14664187313, 3288.901332959991, 4657.371254880582, 4751.14479393709, 4782.1631214537665, 4834.637402194814, 4842.297866809328, 4173.561776013536, 4177.185448837478, 4182.64447521961, 4183.748975061476, 4194.4337514435465, 4957.107720610289, 5125.333706618116, 5135.152699804527, 5137.614678899097, 5152.072626927152, 3396.0491062502538, 3402.931941361184, 3413.3343997920415, 3454.758166928316, 3473.548438702978, 5253.86865328366, 5280.128778751501, 5319.228711836762, 5383.43473935235, 5412.161115027098, 3497.143199916037, 3498.4052711038676, 3505.088676944013, 3513.8594456221977, 3515.068506845688, 3538.9469157962653, 3539.079839241764, 3540.681338679531, 3547.414676578387, 3549.4853246279145, 4055.91888162241, 4123.587641235852, 4131.35963925592, 4198.412222288882, 4228.154369126187, 5214.374275087014, 5224.8171314004585, 5229.137192363218, 5232.215167724796, 5236.581073514109, 1268.3277862732766, 1294.0294778915813, 1294.0359432222865, 1294.4822071171607, 1300.9349532523336, 817.8773184022325, 822.3010441125116, 836.0176792269181, 836.8410002099581, 837.0499483086741, 4987.426445958688, 4989.850304490871, 4999.675021123615, 5016.172331565251, 5027.069992051483, 5424.267723857229, 5424.972875135599, 5429.049916264638, 5451.291332126877, 5525.640833345819, 4987.850364489072, 4994.250862370601, 5002.549770520598, 5008.373953255843, 5110.974445127825, 2908.7236712512276, 2989.910302690923, 3001.4147241288174, 3020.7734419918156, 3030.772692048105, 5459.0173768721215, 5459.153831156177, 5486.231927530149, 5488.4785945335125, 5489.615726899079, 5541.085720856095, 5541.889162216814, 5542.3626282977975, 5570.86072848182, 5651.12407576818, 5445.2921120254905, 5471.124620060851, 5477.397486276506, 5488.0, 5539.279893613885, 5255.500727430888, 5304.07178743726, 5396.406395296436, 5431.293931788842, 5433.7554810034435, 5094.617903657315, 5186.325777648882, 5305.416404195613, 5319.46805319465, 5322.866928326823, 5357.383900851296, 5382.811601594082, 5457.645253058538, 5488.396276409671, 5489.890202195854, 3511.2099777549847, 3545.8404371803845, 3577.0520811984325, 3578.051816268743, 3586.5696116466193, 5345.305110335631, 5437.972810135924, 5456.672599644034, 5461.754221059982, 5480.205370221216, 5134.5635620972635, 5222.503862133091, 5264.947350526446, 5274.657147285414, 5294.708791016531, 5259.763310651107, 5272.393674727456, 5280.1815718563685, 5281.260623512634, 5365.892682146413, 5131.025105229995, 5136.5377116059735, 5137.794488220429, 5149.897002059863, 5163.483651634807, 5087.364079490064, 5277.683338999673, 5280.128778751463, 5291.550218231339, 5294.338207724035, 5177.767000485062, 5179.766910489112, 5181.3005244293045, 5189.377274727057, 5219.373675159005], "yui.html": [599.3497055694571, 613.809718987114, 619.5848781316517, 623.3828509775321, 632.181325183887, 10947.726306842333, 10997.570315858937, 11204.775904481905, 11376.715582110452, 11381.601643942453, 11270.09839212863, 11425.0, 11625.360605166712, 11627.593034243802, 11675.766484670301, 581.9650820950757, 583.1573376471001, 674.4267372733186, 714.8748968930443, 741.9814504637374, 571.7884382778378, 715.967781449836, 726.6040008195546, 737.1854101218157, 739.6523633892062, 748.5172064018705, 774.4578794843604, 777.7783331750452, 785.7917651822272, 787.8896954426356, 609.1259043272918, 609.2688773471807, 610.057461222408, 770.1489853711624, 782.8277778888664, 557.4147145497212, 571.6055921414211, 572.3589579670754, 572.3932631410718, 576.5070864410952, 11425.771484570261, 11501.07991360689, 11512.136589755719, 11673.649790506299, 11716.94141529287, 9526.809463810754, 9549.856752148724, 9601.327907046509, 9742.269329800223, 9923.305368624198, 7658.808529786744, 7707.884381734279, 7711.884321735179, 7818.06183258007, 7939.96030019852, 2617.6073588961617, 2640.93397665058, 2701.13563659629, 2754.118682021754, 2768.958465623017, 39300.803495982334, 40114.0, 40258.39612405816, 40430.79784601058, 40710.185796284204, 7269.236730143259, 7326.67029983652, 7328.706851725978, 7422.96288518554, 7494.587797671181, 15895.920520397323, 15952.840471595135, 16117.51647450555, 16129.354825806837, 16267.186640668157, 5793.536517078624, 5888.087346461305, 5903.498202652822, 5947.1079338099635, 5952.85117872048, 3167.4298626247496, 3174.365126974614, 3194.2174167329154, 3227.9677203227666, 3340.265141668829, 2190.9561808763738, 2241.9215327463785, 2246.1689175005354, 2269.137727663477, 2273.556656451976, 348.94765785131926, 351.5658162169718, 353.6887538965745, 359.53440294818273, 360.56371790134233, 334.86605357857053, 433.44235365135626, 454.4138061900178, 482.8599706085266, 506.59978616892244, 6200.968995154995, 6276.497880169575, 6375.617462952145, 6416.615003099829, 6464.612123272619, 334.2502002019426, 419.4295757769431, 476.47825630934074, 492.77578701690646, 504.74762618690653, 2954.9556756648667, 3076.7538596912195, 3285.5400243965864, 3311.966880331166, 3383.543221665044, 39638.801805990784, 39812.402813957815, 40222.195556088715, 40328.39507407391, 40857.387139192935, 39659.0, 40063.0, 40107.1978560433, 40884.0, 41398.0, 37691.62308376881, 37905.81047094747, 38337.808310958826, 38831.0, 38971.02572435655, 6443.7744678936015, 6448.5163612730175, 6626.337366263335, 6741.325867413219, 6770.390664840188, 27685.0, 28321.57517637196, 28705.0, 28812.711872881002, 29075.709242908146, 34276.657233427344, 34890.82554587211, 36845.0, 38899.222015560095, 39194.0, 6085.543584231289, 6124.846878828065, 6182.072689096672, 6304.71628776697, 6316.05259211122, 8746.387752857494, 8759.430637008574, 9005.684801031932, 9158.633654654006, 9639.421634701941, 8354.206350396702, 8357.95821020891, 8389.874151887849, 8431.578421079044, 8514.063453020039, 8157.0, 8176.918230817853, 8223.79440513968, 8229.382796290183, 8241.093479717347, 7952.324052455375, 8001.039875215011, 8002.359811215205, 8106.392020598597, 8264.958675206586, 7178.246284140299, 7203.747868824566, 7436.182019977907, 7611.029551287831, 7682.807929801576, 6977.162740471176, 6980.406665433292, 7162.104736907887, 7194.424446044409, 7194.460415468965]}, "summary": {"suite": 5323.2166327145405, "subtests": {"jquery.html": {"filtered": 5391.98761975354, "value": 5391.98761975354}, "dojo.html": {"filtered": 4322.000619799027, "value": 4322.000619799027}, "mootools.html": {"filtered": 3401.5268795873453, "value": 3401.5268795873453}, "ext.html": {"filtered": 15177.399399501424, "value": 15177.399399501424}, "prototype.html": {"filtered": 3888.954921465455, "value": 3888.954921465455}, "yui.html": {"filtered": 4862.4838261331615, "value": 4862.4838261331615}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0033"}, "testrun": {"date": 1446704974, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151104204536", "branch": "Fx-Team", "revision": "eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c"}}, {"talos_counters": {}, "results": {"audio-dft": [192.0, 197.0, 206.0, 204.0, 195.0, 198.0, 198.0, 197.0, 206.0, 204.0], "ai-astar": [127.0, 134.0, 125.0, 140.0, 140.0, 135.0, 131.0, 134.0, 123.0, 131.0], "imaging-gaussian-blur": [140.0, 141.0, 149.0, 149.0, 151.0, 148.0, 150.0, 143.0, 149.0, 154.0], "audio-beat-detection": [188.0, 162.0, 191.0, 205.0, 163.0, 187.0, 179.0, 153.0, 204.0, 164.0], "json-stringify-tinderbox": [74.0, 78.0, 85.0, 86.0, 86.0, 86.0, 82.0, 82.0, 82.0, 82.0], "stanford-crypto-pbkdf2": [188.0, 183.0, 191.0, 192.0, 192.0, 176.0, 185.0, 183.0, 187.0, 190.0], "json-parse-financial": [64.0, 68.0, 69.0, 69.0, 69.0, 73.0, 74.0, 83.0, 71.0, 72.0], "stanford-crypto-sha256-iterative": [80.0, 84.0, 85.0, 84.0, 87.0, 90.0, 89.0, 90.0, 89.0, 89.0], "audio-fft": [87.0, 101.0, 102.0, 146.0, 83.0, 90.0, 88.0, 91.0, 144.0, 81.0], "imaging-darkroom": [155.0, 161.0, 162.0, 154.0, 154.0, 162.0, 162.0, 157.0, 154.0, 154.0], "stanford-crypto-ccm": [172.0, 157.0, 165.0, 158.0, 166.0, 160.0, 166.0, 173.0, 164.0, 158.0], "audio-oscillator": [119.0, 121.0, 171.0, 116.0, 115.0, 112.0, 150.0, 109.0, 108.0, 151.0], "stanford-crypto-aes": [104.0, 107.0, 112.0, 114.0, 111.0, 113.0, 112.0, 112.0, 106.0, 108.0], "imaging-desaturate": [122.0, 128.0, 129.0, 129.0, 131.0, 127.0, 129.0, 124.0, 130.0, 130.0]}, "summary": {"suite": 1873.3000000000004, "subtests": {"audio-fft": {"filtered": 101.3, "value": 101.3}, "stanford-crypto-pbkdf2": {"filtered": 186.7, "value": 186.7}, "audio-beat-detection": {"filtered": 179.6, "value": 179.6}, "stanford-crypto-ccm": {"filtered": 163.9, "value": 163.9}, "imaging-darkroom": {"filtered": 157.5, "value": 157.5}, "json-parse-financial": {"filtered": 71.2, "value": 71.2}, "audio-oscillator": {"filtered": 127.2, "value": 127.2}, "ai-astar": {"filtered": 132.0, "value": 132.0}, "audio-dft": {"filtered": 199.7, "value": 199.7}, "stanford-crypto-sha256-iterative": {"filtered": 86.7, "value": 86.7}, "json-stringify-tinderbox": {"filtered": 82.3, "value": 82.3}, "imaging-gaussian-blur": {"filtered": 147.4, "value": 147.4}, "stanford-crypto-aes": {"filtered": 109.9, "value": 109.9}, "imaging-desaturate": {"filtered": 127.9, "value": 127.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0033"}, "testrun": {"date": 1446704974, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151104204536", "branch": "Fx-Team", "revision": "eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c"}}, {"talos_counters": {}, "results": {"DeltaBlue": [244.43901246638964], "Encrypt": [398.5651654045436], "NavierStokes": [7027.972027972028], "Decrypt": [6896.551724137931], "Splay": [772.2007722007722], "Richards": [201.61290322580646], "RegExp": [36727.27272727273], "Earley": [973.7098344693281], "Boyer": [16683.333333333332], "RayTrace": [2549.618320610687]}, "summary": {"suite": 14968.713820389812, "subtests": {"DeltaBlue": {"filtered": 270.48873800000007, "value": 270.48873800000007}, "Encrypt": {"filtered": 667.8481289999999, "value": 667.8481289999999}, "NavierStokes": {"filtered": 211.15621890547268, "value": 211.15621890547268}, "Decrypt": {"filtered": 38.59624499999999, "value": 38.59624499999999}, "Splay": {"filtered": 105.53084499999999, "value": 105.53084499999999}, "RegExp": {"filtered": 24.80404702970295, "value": 24.80404702970295}, "Richards": {"filtered": 175.09791999999993, "value": 175.09791999999993}, "Earley": {"filtered": 684.4575009999998, "value": 684.4575009999998}, "Boyer": {"filtered": 39.94783216783217, "value": 39.94783216783217}, "RayTrace": {"filtered": 290.2352065868264, "value": 290.2352065868264}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0033"}, "testrun": {"date": 1446704974, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151104204536", "branch": "Fx-Team", "revision": "eb607c348695ec27e0f8d2ab97aa7f0e2d9b364c"}}] 22:49:54 INFO - RETURN: dromaeo_css: 5323.22 22:49:54 INFO - RETURN: kraken: 1873.30 22:49:54 INFO - RETURN: v8_7: 14968.71 22:49:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "14968.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1873.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5323.22"}}} 22:49:54 INFO - Return code: 0 22:49:54 INFO - # TBPL SUCCESS # 22:49:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:49:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:49:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:49:54 INFO - 2015-11-04 22:49:54.397 screenresolution[1658:10458] starting screenresolution argv=screenresolution get 22:49:54 INFO - 2015-11-04 22:49:54.401 screenresolution[1658:10458] Display 0: 1600x1200x32@60 22:49:54 INFO - 2015-11-04 22:49:54.408 screenresolution[1659:10461] starting screenresolution argv=screenresolution list 22:49:54 INFO - Available Modes on Display 0 22:49:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:49:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:49:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:49:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:49:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:49:54 INFO - Intel HD Graphics 3000: 22:49:54 INFO - Chipset Model: Intel HD Graphics 3000 22:49:54 INFO - Type: GPU 22:49:54 INFO - Bus: Built-In 22:49:54 INFO - VRAM (Total): 512 MB 22:49:54 INFO - VRAM (Dynamic, Max): 10 22:49:54 INFO - Vendor: Intel (0x8086) 22:49:54 INFO - Device ID: 0x0116 22:49:54 INFO - Revision ID: 0x0009 22:49:54 INFO - Displays: 22:49:54 INFO - Display: 22:49:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:49:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:49:54 INFO - Display Serial Number: 1600x1200 60 22:49:54 INFO - Main Display: Yes 22:49:54 INFO - Mirror: Off 22:49:54 INFO - Online: Yes 22:49:54 INFO - Rotation: Supported 22:49:54 INFO - Return code: 0 22:49:54 INFO - Running post-action listener: _resource_record_post_action 22:49:54 INFO - Running post-run listener: _resource_record_post_run 22:49:55 INFO - Total resource usage - Wall time: 1265s; CPU: 30.0%; Read bytes: 38650880; Write bytes: 685613056; Read time: 4277; Write time: 56001 22:49:55 INFO - install - Wall time: 44s; CPU: 30.0%; Read bytes: 337592832; Write bytes: 334301184; Read time: 38282; Write time: 5416 22:49:55 INFO - run-tests - Wall time: 1221s; CPU: 30.0%; Read bytes: 37573632; Write bytes: 340969472; Read time: 3775; Write time: 49659 22:49:55 INFO - Running post-run listener: _upload_blobber_files 22:49:55 INFO - Blob upload gear active. 22:49:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:49:55 INFO - Copying logs to upload dir... 22:49:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1349.805382 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 29 secs) (at 2015-11-04 22:49:55.850738) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-04 22:49:55.853955) ========= 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.4whKtRhu4K/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.enrs6DKQA6/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010946 build_url: 'https://queue.taskcluster.net/v1/task/CWXvu3b0TeqsbhxLZCa8aw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-04 22:49:55.881945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 22:49:55.882289) ========= 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.4whKtRhu4K/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.enrs6DKQA6/Listeners TMPDIR=/var/folders/ys/g9dt_gzn2n9byqt80y89_7j800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005560 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-04 22:49:55.932805) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-04 22:49:55.933154) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-04 22:49:55.933636) ========= ========= Total master_lag: 0.61 =========