builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0066 starttime: 1447804243.93 results: success (0) buildid: 20151117140619 builduid: b4c53e19185e4465b59d0da99e532b89 revision: 55585709276f4b9c00375a1ec8075198e6d8960f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:43.927811) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:43.928313) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:43.928612) ========= 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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.006921 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.023563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.023977) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.048651) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.049141) ========= 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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.023649 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.100206) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.100587) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.100988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.101324) ========= 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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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-17 15:50:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 10.5M=0.001s 2015-11-17 15:50:44 (10.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.237448 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.356775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.357091) ========= 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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.416546 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.792349) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:44.793169) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55585709276f4b9c00375a1ec8075198e6d8960f --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 55585709276f4b9c00375a1ec8075198e6d8960f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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-17 15:50:44,901 truncating revision to first 12 chars 2015-11-17 15:50:44,902 Setting DEBUG logging. 2015-11-17 15:50:44,902 attempt 1/10 2015-11-17 15:50:44,902 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55585709276f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 15:50:45,177 unpacking tar archive at: fx-team-55585709276f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585270 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:45.397587) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:45.397912) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:45.413646) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:45.414040) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 15:50:45.414516) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 17 secs) (at 2015-11-17 15:50:45.414831) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 15:50:45 INFO - MultiFileLogger online at 20151117 15:50:45 in /builds/slave/test 15:50:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 15:50:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:45 INFO - {'append_to_log': False, 15:50:45 INFO - 'base_work_dir': '/builds/slave/test', 15:50:45 INFO - 'blob_upload_branch': 'Fx-Team', 15:50:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:45 INFO - 'branch': 'Fx-Team', 15:50:45 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:45 INFO - 'config_files': ('talos/mac_config.py',), 15:50:45 INFO - 'default_actions': ('clobber', 15:50:45 INFO - 'read-buildbot-config', 15:50:45 INFO - 'download-and-extract', 15:50:45 INFO - 'populate-webroot', 15:50:45 INFO - 'create-virtualenv', 15:50:45 INFO - 'install', 15:50:45 INFO - 'run-tests'), 15:50:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:45 INFO - 'download_minidump_stackwalk': True, 15:50:45 INFO - 'download_symbols': 'ondemand', 15:50:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:45 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:45 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:45 INFO - 'installer_path': 'installer.exe', 15:50:45 INFO - 'log_level': 'info', 15:50:45 INFO - 'log_name': 'talos', 15:50:45 INFO - 'log_to_console': True, 15:50:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:50:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:50:45 INFO - 'opt_config_files': (), 15:50:45 INFO - 'pip_index': False, 15:50:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:50:45 INFO - 'cmd': ('bash', 15:50:45 INFO - '-c', 15:50:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:50:45 INFO - 'enabled': True, 15:50:45 INFO - 'halt_on_failure': False, 15:50:45 INFO - 'name': 'check_screen_resolution'},), 15:50:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:50:45 INFO - 'cmd': ('bash', 15:50:45 INFO - '-c', 15:50:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:50:45 INFO - 'enabled': True, 15:50:45 INFO - 'halt_on_failure': False, 15:50:45 INFO - 'name': 'check_screen_resolution'},), 15:50:45 INFO - 'run_cmd_checks_enabled': True, 15:50:45 INFO - 'sps_profile': False, 15:50:45 INFO - 'sps_profile_interval': 0, 15:50:45 INFO - 'suite': 'dromaeojs-e10s', 15:50:45 INFO - 'system_bits': '64', 15:50:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:45 INFO - 'title': 't-yosemite-r5-0066', 15:50:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:45 INFO - 'use_talos_json': True, 15:50:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:45 INFO - 'work_dir': 'build'} 15:50:45 INFO - ##### 15:50:45 INFO - ##### Running clobber step. 15:50:45 INFO - ##### 15:50:45 INFO - Running pre-action listener: _resource_record_pre_action 15:50:45 INFO - Running main action method: clobber 15:50:45 INFO - rmtree: /builds/slave/test/build 15:50:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:50 INFO - Running post-action listener: _resource_record_post_action 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running read-buildbot-config step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: read_buildbot_config 15:50:50 INFO - Using buildbot properties: 15:50:50 INFO - { 15:50:50 INFO - "properties": { 15:50:50 INFO - "buildnumber": 50, 15:50:50 INFO - "product": "firefox", 15:50:50 INFO - "script_repo_revision": "production", 15:50:50 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 15:50:50 INFO - "repository": "", 15:50:50 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 15:50:50 INFO - "buildid": "20151117140619", 15:50:50 INFO - "slavename": "t-yosemite-r5-0066", 15:50:50 INFO - "pgo_build": "False", 15:50:50 INFO - "basedir": "/builds/slave/test", 15:50:50 INFO - "project": "", 15:50:50 INFO - "platform": "yosemite", 15:50:50 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:50:50 INFO - "slavebuilddir": "test", 15:50:50 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:50:50 INFO - "branch": "fx-team", 15:50:50 INFO - "repo_path": "integration/fx-team", 15:50:50 INFO - "stage_platform": "macosx64", 15:50:50 INFO - "builduid": "b4c53e19185e4465b59d0da99e532b89", 15:50:50 INFO - "revision": "55585709276f4b9c00375a1ec8075198e6d8960f" 15:50:50 INFO - }, 15:50:50 INFO - "sourcestamp": { 15:50:50 INFO - "repository": "", 15:50:50 INFO - "hasPatch": false, 15:50:50 INFO - "project": "", 15:50:50 INFO - "branch": "fx-team-macosx64-talos", 15:50:50 INFO - "changes": [ 15:50:50 INFO - { 15:50:50 INFO - "category": null, 15:50:50 INFO - "files": [ 15:50:50 INFO - { 15:50:50 INFO - "url": null, 15:50:50 INFO - "name": "https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 15:50:50 INFO - } 15:50:50 INFO - ], 15:50:50 INFO - "repository": "", 15:50:50 INFO - "rev": "55585709276f4b9c00375a1ec8075198e6d8960f", 15:50:50 INFO - "who": "maglione.k@gmail.com", 15:50:50 INFO - "when": 1447803006, 15:50:50 INFO - "number": 6674634, 15:50:50 INFO - "comments": "Bug 1224893: [webext] Queue unexpected messages for subsequent calls to awaitMessage, follow-up. r=me r=billm", 15:50:50 INFO - "project": "", 15:50:50 INFO - "at": "Tue 17 Nov 2015 15:30:06", 15:50:50 INFO - "branch": "fx-team-macosx64-talos", 15:50:50 INFO - "revlink": "", 15:50:50 INFO - "properties": [ 15:50:50 INFO - [ 15:50:50 INFO - "buildid", 15:50:50 INFO - "20151117140619", 15:50:50 INFO - "Change" 15:50:50 INFO - ], 15:50:50 INFO - [ 15:50:50 INFO - "builduid", 15:50:50 INFO - "b4c53e19185e4465b59d0da99e532b89", 15:50:50 INFO - "Change" 15:50:50 INFO - ], 15:50:50 INFO - [ 15:50:50 INFO - "pgo_build", 15:50:50 INFO - "False", 15:50:50 INFO - "Change" 15:50:50 INFO - ] 15:50:50 INFO - ], 15:50:50 INFO - "revision": "55585709276f4b9c00375a1ec8075198e6d8960f" 15:50:50 INFO - } 15:50:50 INFO - ], 15:50:50 INFO - "revision": "55585709276f4b9c00375a1ec8075198e6d8960f" 15:50:50 INFO - } 15:50:50 INFO - } 15:50:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 15:50:50 INFO - Running post-action listener: _resource_record_post_action 15:50:50 INFO - ##### 15:50:50 INFO - ##### Running download-and-extract step. 15:50:50 INFO - ##### 15:50:50 INFO - Running pre-action listener: _resource_record_pre_action 15:50:50 INFO - Running main action method: download_and_extract 15:50:50 INFO - mkdir: /builds/slave/test/build/tests 15:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:50 INFO - https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:50:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/test_packages.json 15:50:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/test_packages.json 15:50:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:50:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:50:51 INFO - Downloaded 1149 bytes. 15:50:51 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:50:51 INFO - Using the following test package requirements: 15:50:51 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:50:51 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:50:51 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 15:50:51 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:50:51 INFO - u'jsshell-mac.zip'], 15:50:51 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:50:51 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 15:50:51 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:50:51 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:50:51 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 15:50:51 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:50:51 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 15:50:51 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:50:51 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 15:50:51 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 15:50:51 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 15:50:51 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 15:50:51 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:51 INFO - https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:50:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:50:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:50:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/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 15:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/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 15:50:52 INFO - Downloaded 17463512 bytes. 15:50:52 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 15:50:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:50:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:50:57 INFO - Return code: 0 15:50:57 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 15:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:50:57 INFO - https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:50:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:50:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:50:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/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 15:50:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/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 15:50:58 INFO - Downloaded 17463512 bytes. 15:50:58 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 15:50:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 15:50:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 15:51:04 INFO - Return code: 0 15:51:04 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')]} 15:51:04 INFO - https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:51:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:51:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:51:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/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 15:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/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 15:51:05 INFO - Downloaded 11131693 bytes. 15:51:05 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 15:51:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 15:51:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 15:51:06 INFO - Return code: 0 15:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:06 INFO - https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:51:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:51:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:51:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 15:51:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CSprtG9ATT-c_d2BKs_AyQ/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 15:51:10 INFO - Downloaded 108840815 bytes. 15:51:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:51:10 INFO - mkdir: /builds/slave/test/properties 15:51:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:10 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:10 INFO - Contents: 15:51:10 INFO - build_url:https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 15:51:10 INFO - Running post-action listener: _resource_record_post_action 15:51:10 INFO - Running post-action listener: set_extra_try_arguments 15:51:10 INFO - ##### 15:51:10 INFO - ##### Running populate-webroot step. 15:51:10 INFO - ##### 15:51:10 INFO - Running pre-action listener: _resource_record_pre_action 15:51:10 INFO - Running main action method: populate_webroot 15:51:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:51:10 INFO - '../fennec_ids.txt'], 15:51:10 INFO - 'tests': ['tcheck2']}, 15:51:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:10 INFO - '--tppagecycles', 15:51:10 INFO - '7'], 15:51:10 INFO - 'tests': ['tsvgm']}}, 15:51:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:51:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:51:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:51:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:51:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:51:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:10 INFO - 'talos_options': ['--e10s'], 15:51:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:10 INFO - 'tests': ['damp', 'tps']}, 15:51:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:10 INFO - 'talos_options': ['--e10s'], 15:51:10 INFO - 'tests': ['damp', 'tps']}, 15:51:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:51:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:10 INFO - 'other': {'tests': ['a11yr', 15:51:10 INFO - 'ts_paint', 15:51:10 INFO - 'tpaint', 15:51:10 INFO - 'sessionrestore', 15:51:10 INFO - 'sessionrestore_no_auto_restore']}, 15:51:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:51:10 INFO - 'tests': ['a11yr', 15:51:10 INFO - 'ts_paint', 15:51:10 INFO - 'tpaint', 15:51:10 INFO - 'sessionrestore', 15:51:10 INFO - 'sessionrestore_no_auto_restore']}, 15:51:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:51:10 INFO - 'tests': ['a11yr', 15:51:10 INFO - 'ts_paint', 15:51:10 INFO - 'tpaint', 15:51:10 INFO - 'sessionrestore', 15:51:10 INFO - 'sessionrestore_no_auto_restore']}, 15:51:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:51:10 INFO - 'tests': ['a11yr', 15:51:10 INFO - 'ts_paint', 15:51:10 INFO - 'tpaint', 15:51:10 INFO - 'sessionrestore', 15:51:10 INFO - 'sessionrestore_no_auto_restore']}, 15:51:10 INFO - 'other_l64': {'tests': ['a11yr', 15:51:10 INFO - 'ts_paint', 15:51:10 INFO - 'tpaint', 15:51:10 INFO - 'sessionrestore', 15:51:10 INFO - 'sessionrestore_no_auto_restore']}, 15:51:10 INFO - 'other_nol64': {'tests': ['a11yr', 15:51:10 INFO - 'ts_paint', 15:51:10 INFO - 'tpaint', 15:51:10 INFO - 'sessionrestore', 15:51:10 INFO - 'sessionrestore_no_auto_restore']}, 15:51:10 INFO - 'svgr': {'tests': ['tsvgx', 15:51:10 INFO - 'tsvgr_opacity', 15:51:10 INFO - 'tart', 15:51:10 INFO - 'tscrollx', 15:51:10 INFO - 'cart']}, 15:51:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:51:10 INFO - 'tests': ['tsvgx', 15:51:10 INFO - 'tsvgr_opacity', 15:51:10 INFO - 'tart', 15:51:10 INFO - 'tscrollx', 15:51:10 INFO - 'cart']}, 15:51:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:10 INFO - 'tests': ['tp5o']}, 15:51:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:10 INFO - 'talos_options': ['--e10s'], 15:51:10 INFO - 'tests': ['tp5o']}, 15:51:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:10 INFO - 'talos_options': ['--xperf_path', 15:51:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:10 INFO - 'tests': ['tp5n']}, 15:51:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:10 INFO - 'talos_options': ['--e10s', 15:51:10 INFO - '--xperf_path', 15:51:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:10 INFO - 'tests': ['tp5n']}}, 15:51:10 INFO - 'talos.zip': {'path': '', 15:51:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:10 INFO - Running post-action listener: _resource_record_post_action 15:51:10 INFO - ##### 15:51:10 INFO - ##### Running create-virtualenv step. 15:51:10 INFO - ##### 15:51:10 INFO - Running pre-action listener: _resource_record_pre_action 15:51:10 INFO - Running main action method: create_virtualenv 15:51:10 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:10 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 15:51:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:10 INFO - Using real prefix '/tools/python27' 15:51:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:11 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:17 INFO - Installing pip.................done. 15:51:17 INFO - Return code: 0 15:51:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:17 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')]} 15:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:17 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')]} 15:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:17 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 0x108b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8559566d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a879f0>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b8c8>, '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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 15:51:17 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 15:51:17 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 15:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cSTQ2Cf1AF/Render', 15:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:17 INFO - 'HOME': '/Users/cltbld', 15:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:17 INFO - 'LOGNAME': 'cltbld', 15:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:17 INFO - 'MOZ_NO_REMOTE': '1', 15:51:17 INFO - 'NO_EM_RESTART': '1', 15:51:17 INFO - 'PAGER': '/bin/cat', 15:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:17 INFO - 'PWD': '/builds/slave/test', 15:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:17 INFO - 'SHELL': '/bin/bash', 15:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gxHWRYeMB/Listeners', 15:51:17 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 15:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:17 INFO - 'USER': 'cltbld', 15:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:17 INFO - 'XPC_FLAGS': '0x0', 15:51:17 INFO - 'XPC_SERVICE_NAME': '0', 15:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:17 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 15:51:17 INFO - Cleaning up... 15:51:17 INFO - Return code: 0 15:51:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:51:17 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')]} 15:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:17 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')]} 15:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:17 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 0x108b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8559566d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a879f0>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b8c8>, '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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 15:51:17 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 15:51:17 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 15:51:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cSTQ2Cf1AF/Render', 15:51:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:17 INFO - 'HOME': '/Users/cltbld', 15:51:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:17 INFO - 'LOGNAME': 'cltbld', 15:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:17 INFO - 'MOZ_NO_REMOTE': '1', 15:51:17 INFO - 'NO_EM_RESTART': '1', 15:51:17 INFO - 'PAGER': '/bin/cat', 15:51:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:17 INFO - 'PWD': '/builds/slave/test', 15:51:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:17 INFO - 'SHELL': '/bin/bash', 15:51:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gxHWRYeMB/Listeners', 15:51:17 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 15:51:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:17 INFO - 'USER': 'cltbld', 15:51:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:17 INFO - 'XPC_FLAGS': '0x0', 15:51:17 INFO - 'XPC_SERVICE_NAME': '0', 15:51:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:18 INFO - Downloading/unpacking psutil>=0.7.1 15:51:18 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 15:51:18 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 15:51:18 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 15:51:18 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 15:51:18 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 15:51:18 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 15:51:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:51:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:51:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:21 INFO - Installing collected packages: psutil 15:51:21 INFO - Running setup.py install for psutil 15:51:21 INFO - building 'psutil._psutil_osx' extension 15:51:21 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 15:51:23 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 15:51:23 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 15:51:23 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 15:51:24 INFO - building 'psutil._psutil_posix' extension 15:51:24 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 15:51:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:51:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:51:24 INFO - ^ 15:51:24 INFO - 1 warning generated. 15:51:24 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 15:51:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:24 INFO - Successfully installed psutil 15:51:24 INFO - Cleaning up... 15:51:24 INFO - Return code: 0 15:51:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:24 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 0x108b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8559566d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a879f0>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b8c8>, '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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 15:51:24 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 15:51:24 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 15:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cSTQ2Cf1AF/Render', 15:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:24 INFO - 'HOME': '/Users/cltbld', 15:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:24 INFO - 'LOGNAME': 'cltbld', 15:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:24 INFO - 'MOZ_NO_REMOTE': '1', 15:51:24 INFO - 'NO_EM_RESTART': '1', 15:51:24 INFO - 'PAGER': '/bin/cat', 15:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:24 INFO - 'PWD': '/builds/slave/test', 15:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:24 INFO - 'SHELL': '/bin/bash', 15:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gxHWRYeMB/Listeners', 15:51:24 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 15:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:24 INFO - 'USER': 'cltbld', 15:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:24 INFO - 'XPC_FLAGS': '0x0', 15:51:24 INFO - 'XPC_SERVICE_NAME': '0', 15:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:51:24 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 15:51:24 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 15:51:24 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 15:51:24 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 15:51:24 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 15:51:24 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 15:51:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:28 INFO - Installing collected packages: mozsystemmonitor 15:51:28 INFO - Running setup.py install for mozsystemmonitor 15:51:28 INFO - Successfully installed mozsystemmonitor 15:51:28 INFO - Cleaning up... 15:51:28 INFO - Return code: 0 15:51:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:28 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')]} 15:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:28 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')]} 15:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:28 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 0x108b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8559566d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a879f0>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b8c8>, '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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 15:51:28 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 15:51:28 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 15:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cSTQ2Cf1AF/Render', 15:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:28 INFO - 'HOME': '/Users/cltbld', 15:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:28 INFO - 'LOGNAME': 'cltbld', 15:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:28 INFO - 'MOZ_NO_REMOTE': '1', 15:51:28 INFO - 'NO_EM_RESTART': '1', 15:51:28 INFO - 'PAGER': '/bin/cat', 15:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:28 INFO - 'PWD': '/builds/slave/test', 15:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:28 INFO - 'SHELL': '/bin/bash', 15:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gxHWRYeMB/Listeners', 15:51:28 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 15:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:28 INFO - 'USER': 'cltbld', 15:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:28 INFO - 'XPC_FLAGS': '0x0', 15:51:28 INFO - 'XPC_SERVICE_NAME': '0', 15:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:28 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:28 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 15:51:28 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 15:51:28 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 15:51:28 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 15:51:28 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 15:51:28 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 15:51:31 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:32 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 15:51:32 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 15:51:32 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 15:51:32 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 15:51:32 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 15:51:32 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 15:51:33 INFO - Downloading docopt-0.6.1.tar.gz 15:51:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:33 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:33 INFO - Running setup.py install for blobuploader 15:51:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:33 INFO - Running setup.py install for requests 15:51:34 INFO - Running setup.py install for docopt 15:51:34 INFO - Successfully installed blobuploader requests docopt 15:51:34 INFO - Cleaning up... 15:51:34 INFO - Return code: 0 15:51:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:34 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 0x108b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8559566d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a879f0>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b8c8>, '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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 15:51:34 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 15:51:34 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 15:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cSTQ2Cf1AF/Render', 15:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:34 INFO - 'HOME': '/Users/cltbld', 15:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:34 INFO - 'LOGNAME': 'cltbld', 15:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:34 INFO - 'MOZ_NO_REMOTE': '1', 15:51:34 INFO - 'NO_EM_RESTART': '1', 15:51:34 INFO - 'PAGER': '/bin/cat', 15:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:34 INFO - 'PWD': '/builds/slave/test', 15:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:34 INFO - 'SHELL': '/bin/bash', 15:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gxHWRYeMB/Listeners', 15:51:34 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 15:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:34 INFO - 'USER': 'cltbld', 15:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:34 INFO - 'XPC_FLAGS': '0x0', 15:51:34 INFO - 'XPC_SERVICE_NAME': '0', 15:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:35 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-6iWSNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:35 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-n5Hn7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:35 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-ZC84JI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:35 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-9z7PiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:35 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-z0jX6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:35 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-xRmIBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:36 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-uQJ6VH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:36 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-1ycscF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:36 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-_0IZHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:36 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-tfXfzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:36 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-vE2Fwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:36 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-Zvz8pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:37 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-QARrIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:37 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-lKNgoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:37 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-F7qbA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:37 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-2VxDX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:37 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-IqVwbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:37 INFO - Running setup.py install for manifestparser 15:51:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:38 INFO - Running setup.py install for mozcrash 15:51:38 INFO - Running setup.py install for mozdebug 15:51:38 INFO - Running setup.py install for mozdevice 15:51:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:38 INFO - Running setup.py install for mozfile 15:51:38 INFO - Running setup.py install for mozhttpd 15:51:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:39 INFO - Running setup.py install for mozinfo 15:51:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:39 INFO - Running setup.py install for mozInstall 15:51:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:39 INFO - Running setup.py install for mozleak 15:51:39 INFO - Running setup.py install for mozlog 15:51:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:40 INFO - Running setup.py install for moznetwork 15:51:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:40 INFO - Running setup.py install for mozprocess 15:51:40 INFO - Running setup.py install for mozprofile 15:51:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:40 INFO - Running setup.py install for mozrunner 15:51:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:40 INFO - Running setup.py install for mozscreenshot 15:51:41 INFO - Running setup.py install for moztest 15:51:41 INFO - Running setup.py install for mozversion 15:51:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:41 INFO - Cleaning up... 15:51:41 INFO - Return code: 0 15:51:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x108b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8559566d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a879f0>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b8c8>, '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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 15:51:41 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 15:51:41 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 15:51:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cSTQ2Cf1AF/Render', 15:51:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:41 INFO - 'HOME': '/Users/cltbld', 15:51:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:41 INFO - 'LOGNAME': 'cltbld', 15:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:41 INFO - 'MOZ_NO_REMOTE': '1', 15:51:41 INFO - 'NO_EM_RESTART': '1', 15:51:41 INFO - 'PAGER': '/bin/cat', 15:51:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:41 INFO - 'PWD': '/builds/slave/test', 15:51:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:41 INFO - 'SHELL': '/bin/bash', 15:51:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gxHWRYeMB/Listeners', 15:51:41 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 15:51:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:41 INFO - 'USER': 'cltbld', 15:51:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:41 INFO - 'XPC_FLAGS': '0x0', 15:51:41 INFO - 'XPC_SERVICE_NAME': '0', 15:51:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:42 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-eqNjcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:42 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)) 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:42 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-05fDcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:42 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)) 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:42 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-kLcDzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:42 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)) 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:42 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-GweuuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:42 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)) 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:42 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-qY0T8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:42 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)) 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:42 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-1nqz_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:42 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)) 15:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:42 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-Jnx0E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:43 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)) 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:43 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-4SVGDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:43 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)) 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:43 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-74uIAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:43 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)) 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:43 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-7PShd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:43 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)) 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:43 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-XT8qIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:43 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)) 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:43 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-Tcr7oZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:43 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)) 15:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:43 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-wGStzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:44 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)) 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:44 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-qeLiX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:44 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)) 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:44 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-hq9nti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:44 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)) 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:44 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-uVeGbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:44 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)) 15:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:44 INFO - Running setup.py (path:/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/pip-y4X2n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:44 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)) 15:51:44 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)) 15:51:44 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)) 15:51:44 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)) 15:51:44 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)) 15:51:44 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)) 15:51:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:44 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 15:51:44 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 15:51:44 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 15:51:44 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 15:51:44 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 15:51:44 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 15:51:47 INFO - Downloading blessings-1.5.1.tar.gz 15:51:47 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 15:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:47 INFO - Installing collected packages: blessings 15:51:47 INFO - Running setup.py install for blessings 15:51:48 INFO - Successfully installed blessings 15:51:48 INFO - Cleaning up... 15:51:48 INFO - Return code: 0 15:51:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:48 INFO - Reading from file tmpfile_stdout 15:51:48 INFO - Current package versions: 15:51:48 INFO - blessings == 1.5.1 15:51:48 INFO - blobuploader == 1.2.4 15:51:48 INFO - docopt == 0.6.1 15:51:48 INFO - manifestparser == 1.1 15:51:48 INFO - mozInstall == 1.12 15:51:48 INFO - mozcrash == 0.16 15:51:48 INFO - mozdebug == 0.1 15:51:48 INFO - mozdevice == 0.47 15:51:48 INFO - mozfile == 1.2 15:51:48 INFO - mozhttpd == 0.7 15:51:48 INFO - mozinfo == 0.9 15:51:48 INFO - mozleak == 0.1 15:51:48 INFO - mozlog == 3.0 15:51:48 INFO - moznetwork == 0.27 15:51:48 INFO - mozprocess == 0.22 15:51:48 INFO - mozprofile == 0.27 15:51:48 INFO - mozrunner == 6.11 15:51:48 INFO - mozscreenshot == 0.1 15:51:48 INFO - mozsystemmonitor == 0.0 15:51:48 INFO - moztest == 0.7 15:51:48 INFO - mozversion == 1.4 15:51:48 INFO - psutil == 3.1.1 15:51:48 INFO - requests == 1.2.3 15:51:48 INFO - wsgiref == 0.1.2 15:51:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:48 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 0x108b64490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b41228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8559566d00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a879f0>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b8c8>, '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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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 15:51:48 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 15:51:48 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 15:51:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cSTQ2Cf1AF/Render', 15:51:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:51:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:51:48 INFO - 'HOME': '/Users/cltbld', 15:51:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:51:48 INFO - 'LOGNAME': 'cltbld', 15:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:48 INFO - 'MOZ_NO_REMOTE': '1', 15:51:48 INFO - 'NO_EM_RESTART': '1', 15:51:48 INFO - 'PAGER': '/bin/cat', 15:51:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:48 INFO - 'PWD': '/builds/slave/test', 15:51:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:51:48 INFO - 'SHELL': '/bin/bash', 15:51:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gxHWRYeMB/Listeners', 15:51:48 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 15:51:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:51:48 INFO - 'USER': 'cltbld', 15:51:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:51:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:48 INFO - 'XPC_FLAGS': '0x0', 15:51:48 INFO - 'XPC_SERVICE_NAME': '0', 15:51:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51: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)) 15:51:49 INFO - Cleaning up... 15:51:49 INFO - Return code: 0 15:51:49 INFO - Running post-action listener: _resource_record_post_action 15:51:49 INFO - Running post-action listener: _start_resource_monitoring 15:51:49 INFO - Starting resource monitoring. 15:51:49 INFO - ##### 15:51:49 INFO - ##### Running install step. 15:51:49 INFO - ##### 15:51:49 INFO - Running pre-action listener: _resource_record_pre_action 15:51:49 INFO - Running main action method: install 15:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:49 INFO - Reading from file tmpfile_stdout 15:51:49 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:49 INFO - Reading from file tmpfile_stdout 15:51:49 INFO - Output received: 15:51:49 INFO - Usage: mozinstall [options] installer 15:51:49 INFO - Options: 15:51:49 INFO - -h, --help show this help message and exit 15:51:49 INFO - -d DEST, --destination=DEST 15:51:49 INFO - Directory to install application into. [default: 15:51:49 INFO - "/builds/slave/test"] 15:51:49 INFO - --app=APP Application being installed. [default: firefox] 15:51:49 INFO - mkdir: /builds/slave/test/build/application 15:51:49 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'] 15:51:49 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 15:52:36 INFO - Reading from file tmpfile_stdout 15:52:36 INFO - Output received: 15:52:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:52:36 INFO - Running post-action listener: _resource_record_post_action 15:52:36 INFO - ##### 15:52:36 INFO - ##### Running run-tests step. 15:52:36 INFO - ##### 15:52:36 INFO - Running pre-action listener: _resource_record_pre_action 15:52:36 INFO - Running main action method: run_tests 15:52:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:52:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:52:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:52:36 INFO - 2015-11-17 15:52:36.718 screenresolution[1637:7596] starting screenresolution argv=screenresolution get 15:52:36 INFO - 2015-11-17 15:52:36.722 screenresolution[1637:7596] Display 0: 1600x1200x32@60 15:52:36 INFO - 2015-11-17 15:52:36.730 screenresolution[1638:7598] starting screenresolution argv=screenresolution list 15:52:36 INFO - Available Modes on Display 0 15:52:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:52:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:52:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:52:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:52:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:52:37 INFO - Intel HD Graphics 3000: 15:52:37 INFO - Chipset Model: Intel HD Graphics 3000 15:52:37 INFO - Type: GPU 15:52:37 INFO - Bus: Built-In 15:52:37 INFO - VRAM (Total): 512 MB 15:52:37 INFO - VRAM (Dynamic, Max): 10 15:52:37 INFO - Vendor: Intel (0x8086) 15:52:37 INFO - Device ID: 0x0116 15:52:37 INFO - Revision ID: 0x0009 15:52:37 INFO - Displays: 15:52:37 INFO - Display: 15:52:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:52:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:52:37 INFO - Display Serial Number: 1600x1200 60 15:52:37 INFO - Main Display: Yes 15:52:37 INFO - Mirror: Off 15:52:37 INFO - Online: Yes 15:52:37 INFO - Rotation: Supported 15:52:37 INFO - Return code: 0 15:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:52:37 INFO - Python 2.7.3 15:52:37 INFO - Return code: 0 15:52:37 INFO - grabbing minidump binary from tooltool 15:52:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:37 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 0x108a879f0>, '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 0x1087e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7b8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:52:37 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 15:52:37 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 15:52:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:37 INFO - Return code: 0 15:52:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:52:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:52:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:52:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:52:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:52:37 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0066', '--webServer', 'localhost'] in /builds/slave/test/build 15:52:37 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0066 --webServer localhost 15:52:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cSTQ2Cf1AF/Render', 15:52:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:52:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:52:37 INFO - 'HOME': '/Users/cltbld', 15:52:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:52:37 INFO - 'LOGNAME': 'cltbld', 15:52:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:52:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:37 INFO - 'MOZ_NO_REMOTE': '1', 15:52:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:52:37 INFO - 'NO_EM_RESTART': '1', 15:52:37 INFO - 'PAGER': '/bin/cat', 15:52:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:37 INFO - 'PWD': '/builds/slave/test', 15:52:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:52:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:52:37 INFO - 'SHELL': '/bin/bash', 15:52:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gxHWRYeMB/Listeners', 15:52:37 INFO - 'TMPDIR': '/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/', 15:52:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:52:37 INFO - 'USER': 'cltbld', 15:52:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:52:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:37 INFO - 'XPC_FLAGS': '0x0', 15:52:37 INFO - 'XPC_SERVICE_NAME': '0', 15:52:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 15:52:37 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0066', '--webServer', 'localhost'] with output_timeout 3600 15:52:37 INFO - mozversion INFO | application_buildid: 20151117140619 15:52:37 INFO - mozversion INFO | application_changeset: 55585709276f4b9c00375a1ec8075198e6d8960f 15:52:37 INFO - mozversion INFO | application_display_name: Nightly 15:52:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:37 INFO - mozversion INFO | application_name: Firefox 15:52:37 INFO - mozversion INFO | application_remotingname: firefox 15:52:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 15:52:37 INFO - mozversion INFO | application_vendor: Mozilla 15:52:37 INFO - mozversion INFO | application_version: 45.0a1 15:52:37 INFO - mozversion INFO | platform_buildid: 20151117140619 15:52:37 INFO - mozversion INFO | platform_changeset: 55585709276f4b9c00375a1ec8075198e6d8960f 15:52:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 15:52:37 INFO - mozversion INFO | platform_version: 45.0a1 15:52:37 INFO - 2015-11-17 15:52:37,573 DEBUG : using testdate: 1447804357 15:52:37 INFO - 2015-11-17 15:52:37,573 DEBUG : actual date: 1447804357 15:52:37 INFO - 2015-11-17 15:52:37,584 INFO : starting webserver on 'localhost:49267' 15:52:37 INFO - 2015-11-17 15:52:37,585 INFO : Starting test suite t-yosemite-r5-0066.e 15:52:37 INFO - 2015-11-17 15:52:37,585 INFO : Starting test dromaeo_css 15:52:37 INFO - 2015-11-17 15:52:37,586 DEBUG : operating with platform_type : mac_ 15:52:37 INFO - 2015-11-17 15:52:37,586 INFO : Initialising browser for dromaeo_css test... 15:52:37 INFO - 2015-11-17 15:52:37,619 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpXUbTQq/profile http://localhost:49267/getInfo.html 15:52:42 INFO - 2015-11-17 15:52:42,559 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:52:42 INFO - 2015-11-17 15:52:42,559 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:52:42 INFO - 2015-11-17 15:52:42,560 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 15:52:42 INFO - 2015-11-17 15:52:42,560 DEBUG : BROWSER_OUTPUT: __metrics 15:52:43 INFO - 2015-11-17 15:52:43,372 INFO : Browser initialized. 15:52:43 INFO - 2015-11-17 15:52:43,372 INFO : Running cycle 1/1 for dromaeo_css test... 15:52:43 INFO - 2015-11-17 15:52:43,373 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpXUbTQq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:52:55 INFO - 2015-11-17 15:52:55,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 241356800 15:52:55 INFO - 2015-11-17 15:52:55,905 DEBUG : BROWSER_OUTPUT: 15:53:45 INFO - 2015-11-17 15:53:45,769 DEBUG : BROWSER_OUTPUT: 1447804425768 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] 15:55:55 INFO - 2015-11-17 15:55:55,378 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 15:55:56 INFO - 2015-11-17 15:55:56,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 270155776 15:55:56 INFO - 2015-11-17 15:55:56,483 DEBUG : BROWSER_OUTPUT: 15:58:58 INFO - 2015-11-17 15:58:58,700 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 15:58:59 INFO - 2015-11-17 15:58:59,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 275652608 15:58:59 INFO - 2015-11-17 15:58:59,294 DEBUG : BROWSER_OUTPUT: 16:02:01 INFO - 2015-11-17 16:02:01,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 16:02:01 INFO - 2015-11-17 16:02:01,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 278138880 16:02:01 INFO - 2015-11-17 16:02:01,700 DEBUG : BROWSER_OUTPUT: 16:05:03 INFO - 2015-11-17 16:05:03,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 16:05:04 INFO - 2015-11-17 16:05:04,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 281427968 16:05:04 INFO - 2015-11-17 16:05:04,154 DEBUG : BROWSER_OUTPUT: 16:08:07 INFO - 2015-11-17 16:08:07,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 16:08:07 INFO - 2015-11-17 16:08:07,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 287412224 16:08:07 INFO - 2015-11-17 16:08:07,662 DEBUG : BROWSER_OUTPUT: 16:11:10 INFO - 2015-11-17 16:11:10,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 16:11:10 INFO - 2015-11-17 16:11:10,276 DEBUG : BROWSER_OUTPUT: RSS: Main: 291483648 16:11:10 INFO - 2015-11-17 16:11:10,276 DEBUG : BROWSER_OUTPUT: 16:11:10 INFO - 2015-11-17 16:11:10,276 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:11:10 INFO - 2015-11-17 16:11:10,276 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:11:10 INFO - 2015-11-17 16:11:10,277 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:11:10 INFO - 2015-11-17 16:11:10,277 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:11:10 INFO - 2015-11-17 16:11:10,277 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2256.8645881247126;2330.1262026739973;2409.5783237933356;2422.612382018875;2427.975720242798;3982.402639604061;4042.353223484247;4055.756654600726;4072.3687828386646;4103.610157035077;3840.5583357913847;3926.68586513079;3940.389239667856;4048.858289959852;4118.897027574312;3575.249197668493;3737.9813100934593;3749.887503374903;3798.9430158547643;3943.9605603944024;87.4528215041885;3704.7591906526122;3705.851186132294;3728.1984373359724;3904.472896159025;3525.700315473188;3532.1346270163845;3632.8183590820618;3704.722145839046;3740.2706472237787;3688.4098544232793;3690.335739566877;3712.7772333659796;3760.2103558252797;3812.90467738306;3520.5423294971747;3652.6712595866234;3658.4695219193068;3770.4909837171904;3773.8490460381554;3881.4177873318945;3903.4925459690057;3906.0820707133803;3935.5670876203594;3962.346212874872;4252.468441444819;4300.892477688083;4334.783260836977;4347.391365208841;4414.536473670282;4040.9393859091842;4095.877123686294;4276.2089013532595;4355.891102722426;4367.3448982652535;4026.7583944963394;4032.6370626643743;4043.0903046814233;4085.632293093636;4182.707314535433;4410.2282100632265;4450.399196108484;4452.888677783081;4478.350639157304;4491.640668746492;3875.1280961783373;3884.4950156479476;4020.155767288902;4086.4483294755423;4247.405363249148;4135.1316223593385;4234.661227101825;4238.427812245307;4247.065645557972;4262.25410553152;4173.353130264753;4182.205380977665;4188.434561334242;4205.306124489486;4223.21870453967;3911.7848518331766;3941.3299739044432;4052.6555242804693;4143.958560414418;4186.037211441386;3237.2877966847254;3243.8864639737494;3246.3507298540385;3277.393682168806;3280.0323904448246;2853.1583182961076;2973.435047340998;2985.5372417275357;2996.280892585807;3014.216303760994;3945.467361906106;4008.9599104008585;4020.4170395292517;4039.2123535910805;4045.1707399982934;4198.055437526532;4203.558626344251;4254.7659878706345;4283.250431174532;4348.108637729258;3835.424686297022;3947.3684210526176;3962.7622342659533;3969.226000929791;3985.6612187964347;3656.323580137683;3745.737798354089;3749.4938183345444;3779.962200377961;3790.753601015925;4298.290782020994;4331.740095594275;4368.388425620416;4371.409859668904;4381.342798580238;4047.655949244347;4083.5303940047274;4155.065110350147;4164.937525937053;4221.873343799691;4397.692161548789;4418.403515525363;4432.534583868776;4461.933071004002;4487.977560112178;4205.642520385802;4206.85276015338;4211.915761684688;4221.451211342506;4234.36484527311;4144.109016561454;4211.957880421279;4276.550962148929;4309.2674245378985;4338.9566104338555;4181.853635122756;4213.052063285736;4227.42929704486;4233;4278.315469524861;4021.235965166609;4172.228137794517;4221.071364299849;4223.493180818322;4230;3900.3759398496104;3986.621270979252;3990.2618015667194;4008.0180355813013;4030.274550580806;3974.9801250994715;4017.055991841856;4113.341865301538;4113.629773320416;4154.314538101179;3854.1713531590844;4049.9392509112977;4053.0475338294887;4054.3715724062818;4093.3859921012086 16:11:10 INFO - 2015-11-17 16:11:10,277 DEBUG : BROWSER_OUTPUT: |1;ext.html;399.287272219089;422.6766523609438;428.33394072217686;428.4900967848261;456.8834947088492;28448.715512844865;29301.267468313305;29315.413691726153;29362.706372936264;29555.556666649965;31255.84372078142;31321.68678313216;31355.372892542135;32014.839925800337;32320;6834.794956151323;6910.067140935985;7005.929940700578;7039.366457018893;7110.928890711079;6633.237177724551;6716.8992465112815;6776.220734615508;6796.490263230253;6947.5831450113155;6783.152105986752;6800.081988931505;6860;6916.20463646682;7014.5440546364325;6501.739930402779;6745.662716864162;6841.589504629738;6863.965680171617;7099.254578269285;6596.109525214083;6708.530402871801;6730.798076057726;6731.427828634572;6750.257471678112;28721.856390718123;29142.708572914424;29185.85407072972;29196.70803291961;29602;1904.1621686458052;1995.1520603743495;2069.954299710276;2345.1674655497395;2403.639454081902;19579.21683132673;20289.188432462684;20322.49193770153;20761.377158685264;20776.48058798527;1785.2501949181244;1789.2306308287432;1791.6954117800005;1807.3041878876595;1850.4541160357726;165985;166948;167944;167958;174001;39504.80247598744;41054.58945410568;41100.58899411027;42680.57319426828;42884;43442.565574343855;43843.56156438459;43903.560964389944;43957.340639890426;45233;11746.353950532632;11919.046476281877;11924.284542927453;11929.164958452826;11962.40187990597;8951.32865035125;8998.415103018282;9069.954650226706;9081.68214112516;9087.409318394282;13787.51743688966;13924.37340319688;13978.790318145237;14010.579682609537;14527.055741376987;5847.6783776891825;6070.908936365958;6094.695265236809;6099.810536945253;6101.237345331833;657.2113463843407;681.1961884975776;765.7970637780993;791.5804623549528;810.6554714246539;20945.58108837815;21060.473488162614;21080.156793728078;21181.15275388998;21211;758.3970743259122;803.4135081390617;816.4448175240774;863.9826006275292;913.8857642794651;10813.243072984815;10875.673729788119;10935.507902144423;10990;10993.074363151323;220684;228397;232920;233551;234728;38935.22129557393;39243.41134882979;39597.80201098976;39609.80195099064;40036;1019.3527110284874;1022.616518805448;1031.0874875735028;1031.7008067660295;1063.7766069125416;20472;20645.17419303211;20646.58706825885;20763.896180519605;21179.576408472054;34351.48472772961;34770.478442822874;35018.824905875306;36103.27793444169;36285;203401;203556;207123;209874;211325;22788.4302892429;23663;23765.64351534694;24133.758662413853;24442.144524942254;28271.434571308047;28871;29040.56439153372;29918.401631966804;30040;23254.534909302056;24761.380965476008;25140.874295628404;25684.229473115836;26014.479710406064;25021.74978250267;25027.499450011263;25247;25514.872425638496;25800.87099564565;25575.360615984748;25829.6125558113;26197.214083577524;26966;27073.1878043659;22940.197093101662;22964;22982.195623153777;23306.184283549996;23390;17418.216180271666;17714.114294284976;17831.46505604834;18142;18151.636967260318 16:11:10 INFO - 2015-11-17 16:11:10,279 DEBUG : BROWSER_OUTPUT: |2;jquery.html;246.34472303672234;249.6243154053151;249.72031324916097;252.17412972515024;254.29433322529977;10426.748790145193;10524.052835244827;12682.302473363961;12823.230606163637;13313.667158321046;12460.376981150928;12518.12373133881;12865.807012894815;13269.872060874837;13270.137441066325;3859.3439115350316;4015.7590544567274;4028.5971402859627;4128.62842344189;4197.034682023122;2902.3469719313093;3082.445159871222;3906.4726261954556;4304.97847510762;4496.280595104784;4374.693771436001;4398.846040388587;4443.4445694288215;4467.932981005288;4533.637309015287;4234.724742891733;4377.233984052794;4388.736675799462;4511.503734589192;4512.864614061584;3836.9040773980596;3852.4413959975645;3903.33643280643;3934;3964.603539646041;15614.76577851333;15673;15680.137592432411;15778.684426311524;16298.185090745415;1512.5613572064087;1536.4775976168157;1626.3088187520257;1690.7886514185727;1720.3978607487404;9677.37097088687;9760.755981100458;10264.589416423334;10370.066693997576;10485.947570262177;1220.6216073017304;1226.4848763519253;1267.5056727876135;1277.5720133755203;1325.8210141630852;43643.78178109089;44426.55573444289;45972;46144.76927615374;46726.29910551345;7061.752838650623;7148.46386521013;7190.532615379983;7237.638118094074;7318.487705860539;8728.389012769045;8732.773142848533;8747.431416957877;9031.954840225757;9043.050479699537;5779.797707080232;5789.942100579025;5794.101914203306;5903.852403689856;5967.134765459071;5870.236869206976;5884.117382392676;5913.76344946206;5922.2597175353085;6054.122152287981;4208.9789551052045;4265.53079161292;4299;4378.255696531597;4445.26653102241;1162.4885050577718;1250.1311588446124;1269.6889262130837;1272.2938768983117;1272.580048583965;656.6683824668512;705.9823504412328;729.1068441159537;798.3413683710962;835.3943391041568;8345.624446899905;8623.870641940375;8666.86999695005;8725.432846864933;12592.559260425842;334.5233042913838;336.3676288577459;348.2060901145393;362.7007718632139;362.8748081911736;4541.5231400703115;4694.084653492604;4719.83480578185;4723.504032076651;4891.706497610155;380826;396099;397653;406595;416829;47485.762571186926;51570.74214628978;51736.741316293934;56528;57079;342.57691750687883;356.75562239865775;358.2816453011747;358.8456963505665;363.60003995604626;7940.28537431634;7943.602819859099;8003.31971782405;8041;8075.353971682134;26648.8667556661;26783.732162678123;27210.78232873908;27235.72764272332;27273;36428.81785591055;36447.635523645484;36806.26387472182;37034.259314814095;37045.073873153386;4427.2252355838245;4544.341070544819;4592.816287348469;4595.701279416827;4608.3778689876435;8130.845325988499;8350.206730360605;8559.272461840814;8603.784905377415;8933.46399216049;6155.784547540994;6267.1539342188225;7323.267673232847;7502.287282708134;7518.360939320219;6892.586444813327;7091.716331346688;7236.493445458767;7254.202037775735;7375.078115235596;7241.710331586678;7354.1246982021385;7584.54492730438;7617.124030736536;7654.578998155155;4392.912141757083;4428.33574963758;4477.552244775497;4601.240795268744;4610.907781844277;7438.44211684115;7467.1039475263315;7485.251474852471;7679.424043196671;7714.807129821799 16:11:10 INFO - 2015-11-17 16:11:10,283 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1127.768807394484;1169.0647482014385;1197.700574856286;1285.794272916333;1329.7407005633904;4940.160172770628;5131.666441681288;5348.277982472365;5727.026405511068;5761.971190144049;5417.349918009844;5494.066008778507;5547.44525547445;5643.322801263854;5706.429357064302;1581.1856893699753;1587.5078725595104;1614.0961061805367;1644.925978330978;1650.0842032671862;1630.6657135287237;1631.8368163183645;1660.5765529789887;1669.7829282193297;1741.930322787087;1664.3093116356697;1698.1169791708305;1719.2263481433342;1740.3995621510558;1759.7976232733208;1596.0982045144515;1624.7969003874516;1644.8601868841163;1700.2603867317757;1704.3267909175806;1615.6930183265142;1638.942637007699;1641.105597449393;1669.1570756767876;1696.9406070787586;5529.198266251411;5537.224788529609;5578.525825304854;5625.184348269478;5676.772929082832;3527.805970671612;3528.788272703646;3542.6457354264626;3567.9821600892087;3611.6388361163936;1948.8928108954;2036.9185232590678;2121.2787652198326;2154.256781410411;2215.5458131083087;684.6884667476286;698.9196242432083;699.3530983839978;703.6059806508372;708.0759608710631;7182.784516464514;7184.209736928934;7190.388816950565;7232.819179520448;7338.046054012998;3181.284211052495;3282.507623856393;3340.6325304216516;3356.4965255211914;3431.987563668724;6368.395002474757;6403.295637479873;6476.158099447041;6550.934490655032;6584.275729669733;3511.1046683095647;3512.5609298837644;3540.274243780019;3596.0650230940146;3605.7656252343513;3200.8239546824684;3222.323312104484;3223.8065716057113;3276.3774882772195;3329.7502687298547;2704.5672692369126;2734.5214587447117;2745.890164393402;2754.476649436601;2783.8051336406256;904.6381447421085;906.7415786500816;912.8402529557301;921.0789210789211;929.939553929006;949.3022628368144;962.5283611030544;964.62379671928;968.6609686609771;1008.5763979128784;5260.842174734764;5282.577393808486;5285.493634314202;5302.045631786238;5503.504684578407;356.8144564826276;357.23373364134306;361.23057886701156;361.2522079295832;361.7865459378979;4164.68764842638;4168.562300958416;4224.091820258659;4247.893802654959;4251.851185208503;6076.361981991916;6079.513638908877;6204.534659900525;6385.914394552937;6727.428168605626;6317.684115794192;6345.143405640272;6369.71336289868;6456.386643268882;6565.343465653396;5189.896202075937;5239.345081864767;5304.045271851027;5354.705491197944;5440.700761458158;4979.153543897473;5037.974810125926;5060.49395060491;5074.619403544675;5128.769205385692;5766.538676905753;5854.063349864001;5856.238688970407;5983.551233657406;6010.669413182317;5963.2844058713235;5965.761369545169;6033.969830150997;6102.786402475892;6163.3528479509005;4673.252279635242;4870.391201099863;4905.215165573634;4910.975445122752;4916.582090522203;5106.285120083117;5166.8966620668125;5216.556592689512;5223.582113430993;5371.40914499397;4862.294967229661;4905.48492408292;4916.950830491649;4941.110600092018;4983.825566105169;4759.381280433521;4807.591354734747;4842.5157484251295;4882.5361590650255;4967.7019378837385;4826.758662066953;4904.803807847647;4918.803247870188;4994.275830004556;5019.774110164978;4486.12520558488;4527.298268768346;4527.728336299832;4531.13908357411;4688.249880019181;4413.911721765611;4418.8453404130705;4447.177272204653;4497.8425755098415;4501.572350626685 16:11:10 INFO - 2015-11-17 16:11:10,284 DEBUG : BROWSER_OUTPUT: |4;prototype.html;231.84350563369722;234.69724055967802;239.80935156550547;240.90604664180972;243.57253020948232;4596.793144308505;4717.221658426355;4752.168370535155;4767.6185905127595;4787.257975013874;4565.086982603484;4708.69393489423;4755.191617425037;4759.3812804335475;4759.738214398207;3604.1169913371195;3607.873724419646;3617.149969757118;3627.093226693327;3705.685016773564;3611.5846677632144;3616.0959760059986;3617.1861331200535;3621.8913432597064;3726.1802403471193;3585;3588.102974256436;3624.1664417184065;3657.76224545405;3685;3361.9495707564406;3504.8948531544092;3575.982120089409;3586.8565257389673;3613.699068335397;2990.1179152150166;2990.985045074761;2995.8951436699613;3008.5938398316166;3109.051739219537;4513.909721805579;4537.31940208968;4555.840545580889;4607.0785842831565;4655.557722016403;3854.1328201154797;3873.69010479161;3978.3236849735613;3982.561918189026;4001.0397504598686;4813.638977076734;4905;4910.975445122787;4942.8764280893265;5021.774020169101;3260.934781304384;3261.641219465857;3262.771605987582;3269.4768836986204;3321.136504508845;5187.377514698261;5208.6093542984045;5221.086309895791;5252.789888404421;5346;3330.400527904952;3334.949975750366;3425.72594192464;3489.842957066938;3556.146524834073;3544.964550354515;3546.6453354664327;3547.5565554305713;3553;3624.8006359649944;4077.2660921033907;4086.8978275542754;4088.3254263046265;4191.685623578243;4209.17921005401;4987.925181122286;4988.700677959334;4994.425641051253;5020;5199.194124910645;1229.5757963502576;1247.5633528265034;1248.1013670157472;1254.5107408110844;1259.8488181418288;801.8797180422984;819.868820988639;821.6302663801314;841.9452735572169;844.5523872347666;4664.997025639436;4808.807647694123;4815.133276010351;4822.276658501182;4958.975205123951;5146.614003949644;5156.767945442464;5159.355080614923;5164.92252616211;5175.171972484384;4719.575238228507;4721.811127554859;4740.525947405232;4742.952570474251;4827.710337379768;2674.130907455046;2751.8073734838767;2790.107165706954;2790.497710412105;2867.7419032287194;5220.738963051832;5238.659487133325;5366.463353664602;5392.946070539245;5525.171224316385;5297.629165958346;5378.489043540857;5389.841184145427;5415.187721841755;5461.781528738806;5386.245925570345;5401.540869026177;5416.350037995545;5475.561955043587;5496.945030549723;5047.965167140801;5203.141481655636;5247.501487358695;5248.58011359098;5255.054090263637;5107.106256405188;5109.054824857413;5111.744412779421;5116.616253780907;5123.359580052494;5386.703731294817;5406.675599464044;5413.729313534386;5426.484483974016;5592.832215033555;3330.1008727643884;3368.2589830237307;3372.8819491317686;3394.507796369463;3452.5856897171498;4960.206366981266;5118.769655365592;5143.177091665316;5164.638475306842;5331.4401987790725;4998.750062496788;5003.074431230234;5017.724025178651;5073.847784566469;5185.870353241199;5014.4484106747495;5021.472745361684;5066.44269130388;5158.123119069692;5170.353705786777;4875.07373599015;4885;4893.290472881484;4914.189158788903;5050.772715227897;4962.702237865596;5002.849914502571;5006.048850718352;5066.36670416198;5111.948880511147;4917.778699958439;4919.532644398776;4936.753162341796;4938.209886418156;5118.513741194581 16:11:10 INFO - 2015-11-17 16:11:10,288 DEBUG : BROWSER_OUTPUT: |5;yui.html;544.7303584725562;549.2694716027684;554.0968221798468;556.4880310114692;593.193725107049;9822.116009559139;9927;9976.650817221398;10139.847902281463;10195.031472010165;9674.951625241863;9797;9905.504724763769;10015.298929074968;10019.298649094566;523.5471317310537;647.4140902483249;661.0744957060107;664.0570390046146;678.0338018323869;522.049869237987;631.3181763695221;650.7624716978316;669.0866966590593;672.7981605518349;666.2404858461358;679.4700133895544;681.400367676444;698.9755358562452;709.464354412418;676.9323067693241;677.1231255524108;677.8102131403215;685.715428097339;694.9756758513453;499.0791988780694;508.01445196319025;513.8997895410397;516.1174391790044;523.3458177278402;10198.082172604501;10343.224258180591;10450.268481206318;10458.320209186379;10564.630237941712;8540.359473039547;8627.180417860292;8692.348073894484;9046.3667543272;9409.341346105775;6924.93075069253;7077.3984211342095;7177.748778792769;7313.817154571125;7381.335679788791;2466.0382450844186;2481.10680155144;2504.161106029482;2528.7724104830468;2567.345326941637;37023.444648330296;37139.25721485555;38165;38270.61729382698;38478.615213847785;6546.509011824132;6639.302873198341;6705.329467053353;6719.764808231688;6898;13636.250006249553;13675;13765.518206862711;13941.512047078304;14402.495912643008;5295.629305948623;5299.4700529946695;5354.303940487712;5405.135178371442;5493.2034854945805;2765.3916138449913;2778.374865655252;2841.7300356466103;2922.006517783964;2942.6321709786275;2130.4567335329393;2168.0785666091847;2168.132746901221;2168.360333701562;2242.887855607213;304.4747810027729;305.08170407074863;310.4024752351714;312.259943932876;317.1136672998973;349.09758274859263;384.29481900712506;395.39109770952984;423.6610711430843;475.98614950155945;5278.788848446019;5921.792737254175;6007.309159446632;6019.337872833985;6138.662373569497;388.72400595577454;404.88460788675087;415.7983378061638;442.9899828391273;446.83020452228595;2664.3605534671537;2829.688734239232;2836.546152615572;2913.2716820794803;2922.8369062987263;42553;43101.982861199416;43765;45084.323735144;45336;35643.643563564554;36773;37563.812180939465;37639.4354084689;38383.61616383801;34098.829505852314;35175.4723679145;35299.82350088233;36196;36227.63772362243;6141.447269745744;6191.5665903388135;6219.502439804714;6297.275813281532;6303.905441418291;25712.614310785728;26340.736592633828;26777.598336024585;26965.86517067402;27365;30887.845560772053;31647.050588482383;31751.364972700878;34528.82735586306;36397.45403818892;5480.725963701879;5487.6158668894395;5504.4495550444635;5744.856378590569;5799.5070419014855;8093.757187284391;8131.7560473185895;8467.703630372907;8750.124987501453;8763.474191548528;7555.73554925575;7837.921620783719;7860.096088949844;7935.484193527403;8375.21769115876;7740.92259077402;7831;7986.640601172845;8061.193880612126;8404.159584041547;7311;7352.338289553966;7633.69465221385;7732.188120247518;8113.310368618733;6666.799996000128;6793.252742198453;6870;6890.793276201722;6947.617881016593;6421.743130274736;6467.579607325509;6514.446272066738;7024.438044956493;7058.11773528309 16:11:10 INFO - 2015-11-17 16:11:10,289 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:11:10 INFO - 2015-11-17 16:11:10,289 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:11:10 INFO - 2015-11-17 16:11:10,289 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,342 16:11:10 INFO - 2015-11-17 16:11:10,289 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:11:10 INFO - 2015-11-17 16:11:10,289 DEBUG : BROWSER_OUTPUT: __startTimestamp1447805470270__endTimestamp 16:11:10 INFO - 2015-11-17 16:11:10,289 DEBUG : BROWSER_OUTPUT: 16:11:10 INFO - 2015-11-17 16:11:10,290 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:11:10 INFO - 2015-11-17 16:11:10,290 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:11:10 INFO - 2015-11-17 16:11:10,290 DEBUG : BROWSER_OUTPUT: 16:11:10 INFO - 2015-11-17 16:11:10,290 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:3932.23 Median:4047.66 stddev:521.32 (12.9%) stddev-sans-first:506.08 16:11:10 INFO - 2015-11-17 16:11:10,292 DEBUG : BROWSER_OUTPUT: Values: 2256.9 2330.1 2409.6 2422.6 2428.0 3982.4 4042.4 4055.8 4072.4 4103.6 3840.6 3926.7 3940.4 4048.9 4118.9 3575.2 3738.0 3749.9 3798.9 3944.0 87.5 3704.8 3705.9 3728.2 3904.5 3525.7 3532.1 3632.8 3704.7 3740.3 3688.4 3690.3 3712.8 3760.2 3812.9 3520.5 3652.7 3658.5 3770.5 3773.8 3881.4 3903.5 3906.1 3935.6 3962.3 4252.5 4300.9 4334.8 4347.4 4414.5 4040.9 4095.9 4276.2 4355.9 4367.3 4026.8 4032.6 4043.1 4085.6 4182.7 4410.2 4450.4 4452.9 4478.4 4491.6 3875.1 3884.5 4020.2 4086.4 4247.4 4135.1 4234.7 4238.4 4247.1 4262.3 4173.4 4182.2 4188.4 4205.3 4223.2 3911.8 3941.3 4052.7 4144.0 4186.0 3237.3 3243.9 3246.4 3277.4 3280.0 2853.2 2973.4 2985.5 2996.3 3014.2 3945.5 4009.0 4020.4 4039.2 4045.2 4198.1 4203.6 4254.8 4283.3 4348.1 3835.4 3947.4 3962.8 3969.2 3985.7 3656.3 3745.7 3749.5 3780.0 3790.8 4298.3 4331.7 4368.4 4371.4 4381.3 4047.7 4083.5 4155.1 4164.9 4221.9 4397.7 4418.4 4432.5 4461.9 4488.0 4205.6 4206.9 4211.9 4221.5 4234.4 4144.1 4212.0 4276.6 4309.3 4339.0 4181.9 4213.1 4227.4 4233.0 4278.3 4021.2 4172.2 4221.1 4223.5 4230.0 3900.4 3986.6 3990.3 4008.0 4030.3 3975.0 4017.1 4113.3 4113.6 4154.3 3854.2 4049.9 4053.0 4054.4 4093.4 16:11:10 INFO - 2015-11-17 16:11:10,292 DEBUG : BROWSER_OUTPUT: 16:11:10 INFO - 2015-11-17 16:11:10,292 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:32828.85 Median:28360.08 stddev:53108.63 (187.3%) stddev-sans-first:53201.80 16:11:10 INFO - 2015-11-17 16:11:10,293 DEBUG : BROWSER_OUTPUT: Values: 399.3 422.7 428.3 428.5 456.9 28448.7 29301.3 29315.4 29362.7 29555.6 31255.8 31321.7 31355.4 32014.8 32320.0 6834.8 6910.1 7005.9 7039.4 7110.9 6633.2 6716.9 6776.2 6796.5 6947.6 6783.2 6800.1 6860.0 6916.2 7014.5 6501.7 6745.7 6841.6 6864.0 7099.3 6596.1 6708.5 6730.8 6731.4 6750.3 28721.9 29142.7 29185.9 29196.7 29602.0 1904.2 1995.2 2070.0 2345.2 2403.6 19579.2 20289.2 20322.5 20761.4 20776.5 1785.3 1789.2 1791.7 1807.3 1850.5 165985.0 166948.0 167944.0 167958.0 174001.0 39504.8 41054.6 41100.6 42680.6 42884.0 43442.6 43843.6 43903.6 43957.3 45233.0 11746.4 11919.0 11924.3 11929.2 11962.4 8951.3 8998.4 9070.0 9081.7 9087.4 13787.5 13924.4 13978.8 14010.6 14527.1 5847.7 6070.9 6094.7 6099.8 6101.2 657.2 681.2 765.8 791.6 810.7 20945.6 21060.5 21080.2 21181.2 21211.0 758.4 803.4 816.4 864.0 913.9 10813.2 10875.7 10935.5 10990.0 10993.1 220684.0 228397.0 232920.0 233551.0 234728.0 38935.2 39243.4 39597.8 39609.8 40036.0 1019.4 1022.6 1031.1 1031.7 1063.8 20472.0 20645.2 20646.6 20763.9 21179.6 34351.5 34770.5 35018.8 36103.3 36285.0 203401.0 203556.0 207123.0 209874.0 211325.0 22788.4 23663.0 23765.6 24133.8 24442.1 28271.4 28871.0 29040.6 29918.4 30040.0 23254.5 24761.4 25140.9 25684.2 26014.5 25021.7 25027.5 25247.0 25514.9 25800.9 25575.4 25829.6 26197.2 26966.0 27073.2 22940.2 22964.0 22982.2 23306.2 23390.0 17418.2 17714.1 17831.5 18142.0 18151.6 16:11:10 INFO - 2015-11-17 16:11:10,294 DEBUG : BROWSER_OUTPUT: 16:11:10 INFO - 2015-11-17 16:11:10,294 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20548.53 Median:24427.45 stddev:65384.70 (267.7%) stddev-sans-first:65550.34 16:11:10 INFO - 2015-11-17 16:11:10,295 DEBUG : BROWSER_OUTPUT: Values: 246.3 249.6 249.7 252.2 254.3 10426.7 10524.1 12682.3 12823.2 13313.7 12460.4 12518.1 12865.8 13269.9 13270.1 3859.3 4015.8 4028.6 4128.6 4197.0 2902.3 3082.4 3906.5 4305.0 4496.3 4374.7 4398.8 4443.4 4467.9 4533.6 4234.7 4377.2 4388.7 4511.5 4512.9 3836.9 3852.4 3903.3 3934.0 3964.6 15614.8 15673.0 15680.1 15778.7 16298.2 1512.6 1536.5 1626.3 1690.8 1720.4 9677.4 9760.8 10264.6 10370.1 10485.9 1220.6 1226.5 1267.5 1277.6 1325.8 43643.8 44426.6 45972.0 46144.8 46726.3 7061.8 7148.5 7190.5 7237.6 7318.5 8728.4 8732.8 8747.4 9032.0 9043.1 5779.8 5789.9 5794.1 5903.9 5967.1 5870.2 5884.1 5913.8 5922.3 6054.1 4209.0 4265.5 4299.0 4378.3 4445.3 1162.5 1250.1 1269.7 1272.3 1272.6 656.7 706.0 729.1 798.3 835.4 8345.6 8623.9 8666.9 8725.4 12592.6 334.5 336.4 348.2 362.7 362.9 4541.5 4694.1 4719.8 4723.5 4891.7 380826.0 396099.0 397653.0 406595.0 416829.0 47485.8 51570.7 51736.7 56528.0 57079.0 342.6 356.8 358.3 358.8 363.6 7940.3 7943.6 8003.3 8041.0 8075.4 26648.9 26783.7 27210.8 27235.7 27273.0 36428.8 36447.6 36806.3 37034.3 37045.1 4427.2 4544.3 4592.8 4595.7 4608.4 8130.8 8350.2 8559.3 8603.8 8933.5 6155.8 6267.2 7323.3 7502.3 7518.4 6892.6 7091.7 7236.5 7254.2 7375.1 7241.7 7354.1 7584.5 7617.1 7654.6 4392.9 4428.3 4477.6 4601.2 4610.9 7438.4 7467.1 7485.3 7679.4 7714.8 16:11:10 INFO - 2015-11-17 16:11:10,295 DEBUG : BROWSER_OUTPUT: 16:11:10 INFO - 2015-11-17 16:11:10,296 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:3876.61 Median:4905.35 stddev:1951.62 (39.8%) stddev-sans-first:1946.15 16:11:10 INFO - 2015-11-17 16:11:10,297 DEBUG : BROWSER_OUTPUT: Values: 1127.8 1169.1 1197.7 1285.8 1329.7 4940.2 5131.7 5348.3 5727.0 5762.0 5417.3 5494.1 5547.4 5643.3 5706.4 1581.2 1587.5 1614.1 1644.9 1650.1 1630.7 1631.8 1660.6 1669.8 1741.9 1664.3 1698.1 1719.2 1740.4 1759.8 1596.1 1624.8 1644.9 1700.3 1704.3 1615.7 1638.9 1641.1 1669.2 1696.9 5529.2 5537.2 5578.5 5625.2 5676.8 3527.8 3528.8 3542.6 3568.0 3611.6 1948.9 2036.9 2121.3 2154.3 2215.5 684.7 698.9 699.4 703.6 708.1 7182.8 7184.2 7190.4 7232.8 7338.0 3181.3 3282.5 3340.6 3356.5 3432.0 6368.4 6403.3 6476.2 6550.9 6584.3 3511.1 3512.6 3540.3 3596.1 3605.8 3200.8 3222.3 3223.8 3276.4 3329.8 2704.6 2734.5 2745.9 2754.5 2783.8 904.6 906.7 912.8 921.1 929.9 949.3 962.5 964.6 968.7 1008.6 5260.8 5282.6 5285.5 5302.0 5503.5 356.8 357.2 361.2 361.3 361.8 4164.7 4168.6 4224.1 4247.9 4251.9 6076.4 6079.5 6204.5 6385.9 6727.4 6317.7 6345.1 6369.7 6456.4 6565.3 5189.9 5239.3 5304.0 5354.7 5440.7 4979.2 5038.0 5060.5 5074.6 5128.8 5766.5 5854.1 5856.2 5983.6 6010.7 5963.3 5965.8 6034.0 6102.8 6163.4 4673.3 4870.4 4905.2 4911.0 4916.6 5106.3 5166.9 5216.6 5223.6 5371.4 4862.3 4905.5 4917.0 4941.1 4983.8 4759.4 4807.6 4842.5 4882.5 4967.7 4826.8 4904.8 4918.8 4994.3 5019.8 4486.1 4527.3 4527.7 4531.1 4688.2 4413.9 4418.8 4447.2 4497.8 4501.6 16:11:10 INFO - 2015-11-17 16:11:10,297 DEBUG : BROWSER_OUTPUT: 16:11:10 INFO - 2015-11-17 16:11:10,297 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4175.62 Median:4811.22 stddev:1292.32 (26.9%) stddev-sans-first:1261.58 16:11:10 INFO - 2015-11-17 16:11:10,299 DEBUG : BROWSER_OUTPUT: Values: 231.8 234.7 239.8 240.9 243.6 4596.8 4717.2 4752.2 4767.6 4787.3 4565.1 4708.7 4755.2 4759.4 4759.7 3604.1 3607.9 3617.1 3627.1 3705.7 3611.6 3616.1 3617.2 3621.9 3726.2 3585.0 3588.1 3624.2 3657.8 3685.0 3361.9 3504.9 3576.0 3586.9 3613.7 2990.1 2991.0 2995.9 3008.6 3109.1 4513.9 4537.3 4555.8 4607.1 4655.6 3854.1 3873.7 3978.3 3982.6 4001.0 4813.6 4905.0 4911.0 4942.9 5021.8 3260.9 3261.6 3262.8 3269.5 3321.1 5187.4 5208.6 5221.1 5252.8 5346.0 3330.4 3334.9 3425.7 3489.8 3556.1 3545.0 3546.6 3547.6 3553.0 3624.8 4077.3 4086.9 4088.3 4191.7 4209.2 4987.9 4988.7 4994.4 5020.0 5199.2 1229.6 1247.6 1248.1 1254.5 1259.8 801.9 819.9 821.6 841.9 844.6 4665.0 4808.8 4815.1 4822.3 4959.0 5146.6 5156.8 5159.4 5164.9 5175.2 4719.6 4721.8 4740.5 4743.0 4827.7 2674.1 2751.8 2790.1 2790.5 2867.7 5220.7 5238.7 5366.5 5392.9 5525.2 5297.6 5378.5 5389.8 5415.2 5461.8 5386.2 5401.5 5416.4 5475.6 5496.9 5048.0 5203.1 5247.5 5248.6 5255.1 5107.1 5109.1 5111.7 5116.6 5123.4 5386.7 5406.7 5413.7 5426.5 5592.8 3330.1 3368.3 3372.9 3394.5 3452.6 4960.2 5118.8 5143.2 5164.6 5331.4 4998.8 5003.1 5017.7 5073.8 5185.9 5014.4 5021.5 5066.4 5158.1 5170.4 4875.1 4885.0 4893.3 4914.2 5050.8 4962.7 5002.8 5006.0 5066.4 5111.9 4917.8 4919.5 4936.8 4938.2 5118.5 16:11:10 INFO - 2015-11-17 16:11:10,299 DEBUG : BROWSER_OUTPUT: 16:11:10 INFO - 2015-11-17 16:11:10,299 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10132.91 Median:2974.93 stddev:12165.63 (408.9%) stddev-sans-first:12178.45 16:11:10 INFO - 2015-11-17 16:11:10,301 DEBUG : BROWSER_OUTPUT: Values: 544.7 549.3 554.1 556.5 593.2 9822.1 9927.0 9976.7 10139.8 10195.0 9675.0 9797.0 9905.5 10015.3 10019.3 523.5 647.4 661.1 664.1 678.0 522.0 631.3 650.8 669.1 672.8 666.2 679.5 681.4 699.0 709.5 676.9 677.1 677.8 685.7 695.0 499.1 508.0 513.9 516.1 523.3 10198.1 10343.2 10450.3 10458.3 10564.6 8540.4 8627.2 8692.3 9046.4 9409.3 6924.9 7077.4 7177.7 7313.8 7381.3 2466.0 2481.1 2504.2 2528.8 2567.3 37023.4 37139.3 38165.0 38270.6 38478.6 6546.5 6639.3 6705.3 6719.8 6898.0 13636.3 13675.0 13765.5 13941.5 14402.5 5295.6 5299.5 5354.3 5405.1 5493.2 2765.4 2778.4 2841.7 2922.0 2942.6 2130.5 2168.1 2168.1 2168.4 2242.9 304.5 305.1 310.4 312.3 317.1 349.1 384.3 395.4 423.7 476.0 5278.8 5921.8 6007.3 6019.3 6138.7 388.7 404.9 415.8 443.0 446.8 2664.4 2829.7 2836.5 2913.3 2922.8 42553.0 43102.0 43765.0 45084.3 45336.0 35643.6 36773.0 37563.8 37639.4 38383.6 34098.8 35175.5 35299.8 36196.0 36227.6 6141.4 6191.6 6219.5 6297.3 6303.9 25712.6 26340.7 26777.6 26965.9 27365.0 30887.8 31647.1 31751.4 34528.8 36397.5 5480.7 5487.6 5504.4 5744.9 5799.5 8093.8 8131.8 8467.7 8750.1 8763.5 7555.7 7837.9 7860.1 7935.5 8375.2 7740.9 7831.0 7986.6 8061.2 8404.2 7311.0 7352.3 7633.7 7732.2 8113.3 6666.8 6793.3 6870.0 6890.8 6947.6 6421.7 6467.6 6514.4 7024.4 7058.1 16:11:10 INFO - 2015-11-17 16:11:10,301 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:11:10 INFO - 2015-11-17 16:11:10,301 DEBUG : BROWSER_OUTPUT: 16:11:10 INFO - 2015-11-17 16:11:10,985 INFO : Browser exited with error code: 0 16:11:11 INFO - 2015-11-17 16:11:11,021 INFO : Completed test dromaeo_css (00:18:33) 16:11:11 INFO - 2015-11-17 16:11:11,022 INFO : Starting test kraken 16:11:11 INFO - 2015-11-17 16:11:11,022 DEBUG : operating with platform_type : mac_ 16:11:11 INFO - 2015-11-17 16:11:11,022 INFO : Initialising browser for kraken test... 16:11:11 INFO - 2015-11-17 16:11:11,039 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmp3m_Djh/profile http://localhost:49267/getInfo.html 16:11:14 INFO - 2015-11-17 16:11:14,754 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:11:14 INFO - 2015-11-17 16:11:14,754 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:11:14 INFO - 2015-11-17 16:11:14,754 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:11:14 INFO - 2015-11-17 16:11:14,754 DEBUG : BROWSER_OUTPUT: __metrics 16:11:15 INFO - 2015-11-17 16:11:15,565 INFO : Browser initialized. 16:11:15 INFO - 2015-11-17 16:11:15,566 INFO : Running cycle 1/1 for kraken test... 16:11:15 INFO - 2015-11-17 16:11:15,566 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmp3m_Djh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:11:27 INFO - 2015-11-17 16:11:27,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 242458624 16:11:27 INFO - 2015-11-17 16:11:27,985 DEBUG : BROWSER_OUTPUT: 16:11:31 INFO - 2015-11-17 16:11:31,169 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:31 INFO - 2015-11-17 16:11:31,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 259837952 16:11:31 INFO - 2015-11-17 16:11:31,808 DEBUG : BROWSER_OUTPUT: 16:11:35 INFO - 2015-11-17 16:11:35,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 16:11:35 INFO - 2015-11-17 16:11:35,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 267538432 16:11:35 INFO - 2015-11-17 16:11:35,779 DEBUG : BROWSER_OUTPUT: 16:11:39 INFO - 2015-11-17 16:11:39,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 16:11:40 INFO - 2015-11-17 16:11:40,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 267169792 16:11:40 INFO - 2015-11-17 16:11:40,038 DEBUG : BROWSER_OUTPUT: 16:11:42 INFO - 2015-11-17 16:11:42,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 16:11:43 INFO - 2015-11-17 16:11:43,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 267321344 16:11:43 INFO - 2015-11-17 16:11:43,042 DEBUG : BROWSER_OUTPUT: 16:11:45 INFO - 2015-11-17 16:11:45,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:46 INFO - 2015-11-17 16:11:46,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 267608064 16:11:46 INFO - 2015-11-17 16:11:46,251 DEBUG : BROWSER_OUTPUT: 16:11:50 INFO - 2015-11-17 16:11:50,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:50 INFO - 2015-11-17 16:11:50,789 DEBUG : BROWSER_OUTPUT: RSS: Main: 267821056 16:11:50 INFO - 2015-11-17 16:11:50,789 DEBUG : BROWSER_OUTPUT: 16:11:54 INFO - 2015-11-17 16:11:54,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:55 INFO - 2015-11-17 16:11:55,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 268517376 16:11:55 INFO - 2015-11-17 16:11:55,460 DEBUG : BROWSER_OUTPUT: 16:11:59 INFO - 2015-11-17 16:11:59,134 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 16:11:59 INFO - 2015-11-17 16:11:59,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 268218368 16:11:59 INFO - 2015-11-17 16:11:59,732 DEBUG : BROWSER_OUTPUT: 16:12:01 INFO - 2015-11-17 16:12:01,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:02 INFO - 2015-11-17 16:12:02,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 267382784 16:12:02 INFO - 2015-11-17 16:12:02,246 DEBUG : BROWSER_OUTPUT: 16:12:04 INFO - 2015-11-17 16:12:04,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:05 INFO - 2015-11-17 16:12:05,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 267345920 16:12:05 INFO - 2015-11-17 16:12:05,129 DEBUG : BROWSER_OUTPUT: 16:12:07 INFO - 2015-11-17 16:12:07,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:08 INFO - 2015-11-17 16:12:08,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 268226560 16:12:08 INFO - 2015-11-17 16:12:08,383 DEBUG : BROWSER_OUTPUT: 16:12:11 INFO - 2015-11-17 16:12:11,640 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:12:12 INFO - 2015-11-17 16:12:12,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 267223040 16:12:12 INFO - 2015-11-17 16:12:12,262 DEBUG : BROWSER_OUTPUT: 16:12:15 INFO - 2015-11-17 16:12:15,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:12:16 INFO - 2015-11-17 16:12:16,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 274313216 16:12:16 INFO - 2015-11-17 16:12:16,265 DEBUG : BROWSER_OUTPUT: 16:12:17 INFO - 2015-11-17 16:12:17,746 DEBUG : BROWSER_OUTPUT: 1447805537743 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] 16:12:18 INFO - 2015-11-17 16:12:18,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 16:12:18 INFO - 2015-11-17 16:12:18,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 281870336 16:12:18 INFO - 2015-11-17 16:12:18,644 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,644 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:12:18 INFO - 2015-11-17 16:12:18,644 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:12:18 INFO - 2015-11-17 16:12:18,644 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:12:18 INFO - 2015-11-17 16:12:18,644 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:12:18 INFO - 2015-11-17 16:12:18,645 DEBUG : BROWSER_OUTPUT: |0;ai-astar;139;138;149;157;155;171;154;156;157;155 16:12:18 INFO - 2015-11-17 16:12:18,645 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;204;177;211;225;184;208;207;180;224;186 16:12:18 INFO - 2015-11-17 16:12:18,645 DEBUG : BROWSER_OUTPUT: |2;audio-dft;211;218;230;233;234;233;233;224;219;220 16:12:18 INFO - 2015-11-17 16:12:18,645 DEBUG : BROWSER_OUTPUT: |3;audio-fft;97;95;105;153;95;101;101;101;134;95 16:12:18 INFO - 2015-11-17 16:12:18,645 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;115;114;166;122;126;129;166;126;127;171 16:12:18 INFO - 2015-11-17 16:12:18,645 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;165;165;174;166;166;167;166;166;174;175 16:12:18 INFO - 2015-11-17 16:12:18,645 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;183;182;183;184;183;183;182;182;183;182 16:12:18 INFO - 2015-11-17 16:12:18,646 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;141;136;144;152;135;136;138;156;157;156 16:12:18 INFO - 2015-11-17 16:12:18,646 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;81;83;83;87;88;86;92;93;94;97 16:12:18 INFO - 2015-11-17 16:12:18,646 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;91;89;94;95;98;100;101;101;102;102 16:12:18 INFO - 2015-11-17 16:12:18,646 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;111;118;119;124;124;123;124;126;136;133 16:12:18 INFO - 2015-11-17 16:12:18,646 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;165;167;179;181;191;180;179;180;186;186 16:12:18 INFO - 2015-11-17 16:12:18,646 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;187;217;224;226;225;216;223;225;223;222 16:12:18 INFO - 2015-11-17 16:12:18,647 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;92;93;97;98;97;106;111;108;113;117 16:12:18 INFO - 2015-11-17 16:12:18,647 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:12:18 INFO - 2015-11-17 16:12:18,647 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:12:18 INFO - 2015-11-17 16:12:18,647 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,872 16:12:18 INFO - 2015-11-17 16:12:18,647 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:12:18 INFO - 2015-11-17 16:12:18,648 DEBUG : BROWSER_OUTPUT: __startTimestamp1447805538642__endTimestamp 16:12:18 INFO - 2015-11-17 16:12:18,648 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,648 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:12:18 INFO - 2015-11-17 16:12:18,649 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:12:18 INFO - 2015-11-17 16:12:18,649 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,650 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:153.10 Median:155.50 stddev:9.49 (6.1%) stddev-sans-first:8.59 16:12:18 INFO - 2015-11-17 16:12:18,651 DEBUG : BROWSER_OUTPUT: Values: 139.0 138.0 149.0 157.0 155.0 171.0 154.0 156.0 157.0 155.0 16:12:18 INFO - 2015-11-17 16:12:18,651 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,651 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:200.60 Median:207.50 stddev:17.73 (8.5%) stddev-sans-first:18.76 16:12:18 INFO - 2015-11-17 16:12:18,651 DEBUG : BROWSER_OUTPUT: Values: 204.0 177.0 211.0 225.0 184.0 208.0 207.0 180.0 224.0 186.0 16:12:18 INFO - 2015-11-17 16:12:18,652 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,652 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:225.50 Median:231.50 stddev:8.18 (3.5%) stddev-sans-first:6.79 16:12:18 INFO - 2015-11-17 16:12:18,652 DEBUG : BROWSER_OUTPUT: Values: 211.0 218.0 230.0 233.0 234.0 233.0 233.0 224.0 219.0 220.0 16:12:18 INFO - 2015-11-17 16:12:18,653 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,653 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:107.70 Median:124.00 stddev:19.68 (15.9%) stddev-sans-first:20.48 16:12:18 INFO - 2015-11-17 16:12:18,653 DEBUG : BROWSER_OUTPUT: Values: 97.0 95.0 105.0 153.0 95.0 101.0 101.0 101.0 134.0 95.0 16:12:18 INFO - 2015-11-17 16:12:18,653 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,653 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:136.20 Median:128.00 stddev:22.30 (17.4%) stddev-sans-first:22.29 16:12:18 INFO - 2015-11-17 16:12:18,654 DEBUG : BROWSER_OUTPUT: Values: 115.0 114.0 166.0 122.0 126.0 129.0 166.0 126.0 127.0 171.0 16:12:18 INFO - 2015-11-17 16:12:18,654 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,655 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:168.40 Median:166.50 stddev:4.14 (2.5%) stddev-sans-first:4.21 16:12:18 INFO - 2015-11-17 16:12:18,655 DEBUG : BROWSER_OUTPUT: Values: 165.0 165.0 174.0 166.0 166.0 167.0 166.0 166.0 174.0 175.0 16:12:18 INFO - 2015-11-17 16:12:18,656 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,656 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:182.70 Median:183.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 16:12:18 INFO - 2015-11-17 16:12:18,656 DEBUG : BROWSER_OUTPUT: Values: 183.0 182.0 183.0 184.0 183.0 183.0 182.0 182.0 183.0 182.0 16:12:18 INFO - 2015-11-17 16:12:18,656 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,656 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:145.10 Median:148.00 stddev:9.21 (6.2%) stddev-sans-first:9.65 16:12:18 INFO - 2015-11-17 16:12:18,657 DEBUG : BROWSER_OUTPUT: Values: 141.0 136.0 144.0 152.0 135.0 136.0 138.0 156.0 157.0 156.0 16:12:18 INFO - 2015-11-17 16:12:18,657 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,657 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:88.40 Median:90.00 stddev:5.38 (6.0%) stddev-sans-first:4.99 16:12:18 INFO - 2015-11-17 16:12:18,658 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 83.0 87.0 88.0 86.0 92.0 93.0 94.0 97.0 16:12:18 INFO - 2015-11-17 16:12:18,658 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,658 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:97.30 Median:90.00 stddev:4.76 (5.3%) stddev-sans-first:4.47 16:12:18 INFO - 2015-11-17 16:12:18,658 DEBUG : BROWSER_OUTPUT: Values: 91.0 89.0 94.0 95.0 98.0 100.0 101.0 101.0 102.0 102.0 16:12:18 INFO - 2015-11-17 16:12:18,658 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,659 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:123.80 Median:124.00 stddev:7.15 (5.8%) stddev-sans-first:5.89 16:12:18 INFO - 2015-11-17 16:12:18,660 DEBUG : BROWSER_OUTPUT: Values: 111.0 118.0 119.0 124.0 124.0 123.0 124.0 126.0 136.0 133.0 16:12:18 INFO - 2015-11-17 16:12:18,660 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,660 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:179.40 Median:180.50 stddev:8.07 (4.5%) stddev-sans-first:6.67 16:12:18 INFO - 2015-11-17 16:12:18,660 DEBUG : BROWSER_OUTPUT: Values: 165.0 167.0 179.0 181.0 191.0 180.0 179.0 180.0 186.0 186.0 16:12:18 INFO - 2015-11-17 16:12:18,660 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,661 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:218.80 Median:223.50 stddev:11.66 (5.2%) stddev-sans-first:3.54 16:12:18 INFO - 2015-11-17 16:12:18,661 DEBUG : BROWSER_OUTPUT: Values: 187.0 217.0 224.0 226.0 225.0 216.0 223.0 225.0 223.0 222.0 16:12:18 INFO - 2015-11-17 16:12:18,661 DEBUG : BROWSER_OUTPUT: 16:12:18 INFO - 2015-11-17 16:12:18,661 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:103.20 Median:92.50 stddev:8.89 (9.6%) stddev-sans-first:8.46 16:12:18 INFO - 2015-11-17 16:12:18,661 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 97.0 98.0 97.0 106.0 111.0 108.0 113.0 117.0 16:12:18 INFO - 2015-11-17 16:12:18,661 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:12:18 INFO - 2015-11-17 16:12:18,661 DEBUG : BROWSER_OUTPUT: 16:12:19 INFO - 2015-11-17 16:12:19,339 INFO : Browser exited with error code: 0 16:12:19 INFO - 2015-11-17 16:12:19,404 INFO : Completed test kraken (00:01:08) 16:12:19 INFO - 2015-11-17 16:12:19,404 INFO : Starting test v8_7 16:12:19 INFO - 2015-11-17 16:12:19,404 DEBUG : operating with platform_type : mac_ 16:12:19 INFO - 2015-11-17 16:12:19,404 INFO : Initialising browser for v8_7 test... 16:12:19 INFO - 2015-11-17 16:12:19,422 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpVO6CT6/profile http://localhost:49267/getInfo.html 16:12:22 INFO - 2015-11-17 16:12:22,985 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:12:22 INFO - 2015-11-17 16:12:22,985 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:12:22 INFO - 2015-11-17 16:12:22,985 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:12:22 INFO - 2015-11-17 16:12:22,985 DEBUG : BROWSER_OUTPUT: __metrics 16:12:23 INFO - 2015-11-17 16:12:23,788 INFO : Browser initialized. 16:12:23 INFO - 2015-11-17 16:12:23,789 INFO : Running cycle 1/1 for v8_7 test... 16:12:23 INFO - 2015-11-17 16:12:23,789 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/T/tmpVO6CT6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:12:36 INFO - 2015-11-17 16:12:36,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 240930816 16:12:36 INFO - 2015-11-17 16:12:36,240 DEBUG : BROWSER_OUTPUT: 16:12:58 INFO - 2015-11-17 16:12:58,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/v8_7/run.html (next: http://localhost:49267/tests/v8_7/run.html) 16:12:59 INFO - 2015-11-17 16:12:59,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 260956160 16:12:59 INFO - 2015-11-17 16:12:59,032 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,032 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:12:59 INFO - 2015-11-17 16:12:59,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:12:59 INFO - 2015-11-17 16:12:59,032 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:12:59 INFO - 2015-11-17 16:12:59,032 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:12:59 INFO - 2015-11-17 16:12:59,033 DEBUG : BROWSER_OUTPUT: |0;Richards;220.99447513812154 16:12:59 INFO - 2015-11-17 16:12:59,033 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;267.8093197643278 16:12:59 INFO - 2015-11-17 16:12:59,033 DEBUG : BROWSER_OUTPUT: |2;Encrypt;434.97172683775557 16:12:59 INFO - 2015-11-17 16:12:59,033 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7820.3125 16:12:59 INFO - 2015-11-17 16:12:59,034 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1622.3662884927066 16:12:59 INFO - 2015-11-17 16:12:59,034 DEBUG : BROWSER_OUTPUT: |5;Earley;1074.1138560687432 16:12:59 INFO - 2015-11-17 16:12:59,034 DEBUG : BROWSER_OUTPUT: |6;Boyer;17293.103448275862 16:12:59 INFO - 2015-11-17 16:12:59,034 DEBUG : BROWSER_OUTPUT: |7;RegExp;39784.313725490196 16:12:59 INFO - 2015-11-17 16:12:59,035 DEBUG : BROWSER_OUTPUT: |8;Splay;976.6081871345029 16:12:59 INFO - 2015-11-17 16:12:59,035 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7590.909090909091 16:12:59 INFO - 2015-11-17 16:12:59,035 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:12:59 INFO - 2015-11-17 16:12:59,035 DEBUG : BROWSER_OUTPUT: __startTimestamp1447805579031__endTimestamp 16:12:59 INFO - 2015-11-17 16:12:59,035 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,035 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:12:59 INFO - 2015-11-17 16:12:59,036 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:12:59 INFO - 2015-11-17 16:12:59,036 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,037 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:220.99 Median:220.99 stddev:0.00 (0.0%) 16:12:59 INFO - 2015-11-17 16:12:59,038 DEBUG : BROWSER_OUTPUT: Values: 221.0 16:12:59 INFO - 2015-11-17 16:12:59,038 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,038 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:267.81 Median:267.81 stddev:0.00 (0.0%) 16:12:59 INFO - 2015-11-17 16:12:59,039 DEBUG : BROWSER_OUTPUT: Values: 267.8 16:12:59 INFO - 2015-11-17 16:12:59,039 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,039 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:434.97 Median:434.97 stddev:0.00 (0.0%) 16:12:59 INFO - 2015-11-17 16:12:59,039 DEBUG : BROWSER_OUTPUT: Values: 435.0 16:12:59 INFO - 2015-11-17 16:12:59,039 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,039 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7820.31 Median:7820.31 stddev:0.00 (0.0%) 16:12:59 INFO - 2015-11-17 16:12:59,039 DEBUG : BROWSER_OUTPUT: Values: 7820.3 16:12:59 INFO - 2015-11-17 16:12:59,040 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,040 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1622.37 Median:1622.37 stddev:0.00 (0.0%) 16:12:59 INFO - 2015-11-17 16:12:59,040 DEBUG : BROWSER_OUTPUT: Values: 1622.4 16:12:59 INFO - 2015-11-17 16:12:59,040 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,040 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1074.11 Median:1074.11 stddev:0.00 (0.0%) 16:12:59 INFO - 2015-11-17 16:12:59,040 DEBUG : BROWSER_OUTPUT: Values: 1074.1 16:12:59 INFO - 2015-11-17 16:12:59,041 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,041 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:17293.10 Median:17293.10 stddev:0.00 (0.0%) 16:12:59 INFO - 2015-11-17 16:12:59,041 DEBUG : BROWSER_OUTPUT: Values: 17293.1 16:12:59 INFO - 2015-11-17 16:12:59,041 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,041 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:39784.31 Median:39784.31 stddev:0.00 (0.0%) 16:12:59 INFO - 2015-11-17 16:12:59,041 DEBUG : BROWSER_OUTPUT: Values: 39784.3 16:12:59 INFO - 2015-11-17 16:12:59,042 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,042 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:976.61 Median:976.61 stddev:0.00 (0.0%) 16:12:59 INFO - 2015-11-17 16:12:59,042 DEBUG : BROWSER_OUTPUT: Values: 976.6 16:12:59 INFO - 2015-11-17 16:12:59,042 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,042 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7590.91 Median:7590.91 stddev:0.00 (0.0%) 16:12:59 INFO - 2015-11-17 16:12:59,042 DEBUG : BROWSER_OUTPUT: Values: 7590.9 16:12:59 INFO - 2015-11-17 16:12:59,042 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:12:59 INFO - 2015-11-17 16:12:59,042 DEBUG : BROWSER_OUTPUT: 16:12:59 INFO - 2015-11-17 16:12:59,859 INFO : Browser exited with error code: 0 16:12:59 INFO - 2015-11-17 16:12:59,886 INFO : Completed test v8_7 (00:00:40) 16:13:00 INFO - 2015-11-17 16:13:00,082 INFO : Completed test suite (00:20:22) 16:13:00 INFO - 2015-11-17 16:13:00,083 DEBUG : Working with test: dromaeo_css 16:13:00 INFO - 2015-11-17 16:13:00,083 DEBUG : Generating results file: dromaeo_css 16:13:00 INFO - 2015-11-17 16:13:00,084 DEBUG : Working with test: kraken 16:13:00 INFO - 2015-11-17 16:13:00,084 DEBUG : Generating results file: kraken 16:13:00 INFO - 2015-11-17 16:13:00,084 INFO : javascript benchmark 16:13:00 INFO - 2015-11-17 16:13:00,085 DEBUG : Working with test: v8_7 16:13:00 INFO - 2015-11-17 16:13:00,085 DEBUG : Generating results file: v8_7 16:13:00 INFO - 2015-11-17 16:13:00,085 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:13:00 INFO - 2015-11-17 16:13:00,138 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 16:13:00 INFO - 2015-11-17 16:13:00,138 DEBUG : process_Request line: dromaeo_css 5025.79 graph.html#tests=[[72,64,57]] 16:13:00 INFO - 2015-11-17 16:13:00,138 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:13:00 INFO - 2015-11-17 16:13:00,170 DEBUG : process_Request line: kraken 2130.20 graph.html#tests=[[232,64,57]] 16:13:00 INFO - 2015-11-17 16:13:00,170 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:13:00 INFO - 2015-11-17 16:13:00,195 DEBUG : process_Request line: v8_7 14291.61 graph.html#tests=[[230,64,57]] 16:13:00 INFO - 2015-11-17 16:13:00,196 INFO : javascript benchmark 16:13:00 INFO - 2015-11-17 16:13:00,199 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [246.34472303672234, 249.6243154053151, 249.72031324916097, 252.17412972515024, 254.29433322529977, 10426.748790145193, 10524.052835244827, 12682.302473363961, 12823.230606163637, 13313.667158321046, 12460.376981150928, 12518.12373133881, 12865.807012894815, 13269.872060874837, 13270.137441066325, 3859.3439115350316, 4015.7590544567274, 4028.5971402859627, 4128.62842344189, 4197.034682023122, 2902.3469719313093, 3082.445159871222, 3906.4726261954556, 4304.97847510762, 4496.280595104784, 4374.693771436001, 4398.846040388587, 4443.4445694288215, 4467.932981005288, 4533.637309015287, 4234.724742891733, 4377.233984052794, 4388.736675799462, 4511.503734589192, 4512.864614061584, 3836.9040773980596, 3852.4413959975645, 3903.33643280643, 3934.0, 3964.603539646041, 15614.76577851333, 15673.0, 15680.137592432411, 15778.684426311524, 16298.185090745415, 1512.5613572064087, 1536.4775976168157, 1626.3088187520257, 1690.7886514185727, 1720.3978607487404, 9677.37097088687, 9760.755981100458, 10264.589416423334, 10370.066693997576, 10485.947570262177, 1220.6216073017304, 1226.4848763519253, 1267.5056727876135, 1277.5720133755203, 1325.8210141630852, 43643.78178109089, 44426.55573444289, 45972.0, 46144.76927615374, 46726.29910551345, 7061.752838650623, 7148.46386521013, 7190.532615379983, 7237.638118094074, 7318.487705860539, 8728.389012769045, 8732.773142848533, 8747.431416957877, 9031.954840225757, 9043.050479699537, 5779.797707080232, 5789.942100579025, 5794.101914203306, 5903.852403689856, 5967.134765459071, 5870.236869206976, 5884.117382392676, 5913.76344946206, 5922.2597175353085, 6054.122152287981, 4208.9789551052045, 4265.53079161292, 4299.0, 4378.255696531597, 4445.26653102241, 1162.4885050577718, 1250.1311588446124, 1269.6889262130837, 1272.2938768983117, 1272.580048583965, 656.6683824668512, 705.9823504412328, 729.1068441159537, 798.3413683710962, 835.3943391041568, 8345.624446899905, 8623.870641940375, 8666.86999695005, 8725.432846864933, 12592.559260425842, 334.5233042913838, 336.3676288577459, 348.2060901145393, 362.7007718632139, 362.8748081911736, 4541.5231400703115, 4694.084653492604, 4719.83480578185, 4723.504032076651, 4891.706497610155, 380826.0, 396099.0, 397653.0, 406595.0, 416829.0, 47485.762571186926, 51570.74214628978, 51736.741316293934, 56528.0, 57079.0, 342.57691750687883, 356.75562239865775, 358.2816453011747, 358.8456963505665, 363.60003995604626, 7940.28537431634, 7943.602819859099, 8003.31971782405, 8041.0, 8075.353971682134, 26648.8667556661, 26783.732162678123, 27210.78232873908, 27235.72764272332, 27273.0, 36428.81785591055, 36447.635523645484, 36806.26387472182, 37034.259314814095, 37045.073873153386, 4427.2252355838245, 4544.341070544819, 4592.816287348469, 4595.701279416827, 4608.3778689876435, 8130.845325988499, 8350.206730360605, 8559.272461840814, 8603.784905377415, 8933.46399216049, 6155.784547540994, 6267.1539342188225, 7323.267673232847, 7502.287282708134, 7518.360939320219, 6892.586444813327, 7091.716331346688, 7236.493445458767, 7254.202037775735, 7375.078115235596, 7241.710331586678, 7354.1246982021385, 7584.54492730438, 7617.124030736536, 7654.578998155155, 4392.912141757083, 4428.33574963758, 4477.552244775497, 4601.240795268744, 4610.907781844277, 7438.44211684115, 7467.1039475263315, 7485.251474852471, 7679.424043196671, 7714.807129821799], "dojo.html": [2256.8645881247126, 2330.1262026739973, 2409.5783237933356, 2422.612382018875, 2427.975720242798, 3982.402639604061, 4042.353223484247, 4055.756654600726, 4072.3687828386646, 4103.610157035077, 3840.5583357913847, 3926.68586513079, 3940.389239667856, 4048.858289959852, 4118.897027574312, 3575.249197668493, 3737.9813100934593, 3749.887503374903, 3798.9430158547643, 3943.9605603944024, 87.4528215041885, 3704.7591906526122, 3705.851186132294, 3728.1984373359724, 3904.472896159025, 3525.700315473188, 3532.1346270163845, 3632.8183590820618, 3704.722145839046, 3740.2706472237787, 3688.4098544232793, 3690.335739566877, 3712.7772333659796, 3760.2103558252797, 3812.90467738306, 3520.5423294971747, 3652.6712595866234, 3658.4695219193068, 3770.4909837171904, 3773.8490460381554, 3881.4177873318945, 3903.4925459690057, 3906.0820707133803, 3935.5670876203594, 3962.346212874872, 4252.468441444819, 4300.892477688083, 4334.783260836977, 4347.391365208841, 4414.536473670282, 4040.9393859091842, 4095.877123686294, 4276.2089013532595, 4355.891102722426, 4367.3448982652535, 4026.7583944963394, 4032.6370626643743, 4043.0903046814233, 4085.632293093636, 4182.707314535433, 4410.2282100632265, 4450.399196108484, 4452.888677783081, 4478.350639157304, 4491.640668746492, 3875.1280961783373, 3884.4950156479476, 4020.155767288902, 4086.4483294755423, 4247.405363249148, 4135.1316223593385, 4234.661227101825, 4238.427812245307, 4247.065645557972, 4262.25410553152, 4173.353130264753, 4182.205380977665, 4188.434561334242, 4205.306124489486, 4223.21870453967, 3911.7848518331766, 3941.3299739044432, 4052.6555242804693, 4143.958560414418, 4186.037211441386, 3237.2877966847254, 3243.8864639737494, 3246.3507298540385, 3277.393682168806, 3280.0323904448246, 2853.1583182961076, 2973.435047340998, 2985.5372417275357, 2996.280892585807, 3014.216303760994, 3945.467361906106, 4008.9599104008585, 4020.4170395292517, 4039.2123535910805, 4045.1707399982934, 4198.055437526532, 4203.558626344251, 4254.7659878706345, 4283.250431174532, 4348.108637729258, 3835.424686297022, 3947.3684210526176, 3962.7622342659533, 3969.226000929791, 3985.6612187964347, 3656.323580137683, 3745.737798354089, 3749.4938183345444, 3779.962200377961, 3790.753601015925, 4298.290782020994, 4331.740095594275, 4368.388425620416, 4371.409859668904, 4381.342798580238, 4047.655949244347, 4083.5303940047274, 4155.065110350147, 4164.937525937053, 4221.873343799691, 4397.692161548789, 4418.403515525363, 4432.534583868776, 4461.933071004002, 4487.977560112178, 4205.642520385802, 4206.85276015338, 4211.915761684688, 4221.451211342506, 4234.36484527311, 4144.109016561454, 4211.957880421279, 4276.550962148929, 4309.2674245378985, 4338.9566104338555, 4181.853635122756, 4213.052063285736, 4227.42929704486, 4233.0, 4278.315469524861, 4021.235965166609, 4172.228137794517, 4221.071364299849, 4223.493180818322, 4230.0, 3900.3759398496104, 3986.621270979252, 3990.2618015667194, 4008.0180355813013, 4030.274550580806, 3974.9801250994715, 4017.055991841856, 4113.341865301538, 4113.629773320416, 4154.314538101179, 3854.1713531590844, 4049.9392509112977, 4053.0475338294887, 4054.3715724062818, 4093.3859921012086], "mootools.html": [1127.768807394484, 1169.0647482014385, 1197.700574856286, 1285.794272916333, 1329.7407005633904, 4940.160172770628, 5131.666441681288, 5348.277982472365, 5727.026405511068, 5761.971190144049, 5417.349918009844, 5494.066008778507, 5547.44525547445, 5643.322801263854, 5706.429357064302, 1581.1856893699753, 1587.5078725595104, 1614.0961061805367, 1644.925978330978, 1650.0842032671862, 1630.6657135287237, 1631.8368163183645, 1660.5765529789887, 1669.7829282193297, 1741.930322787087, 1664.3093116356697, 1698.1169791708305, 1719.2263481433342, 1740.3995621510558, 1759.7976232733208, 1596.0982045144515, 1624.7969003874516, 1644.8601868841163, 1700.2603867317757, 1704.3267909175806, 1615.6930183265142, 1638.942637007699, 1641.105597449393, 1669.1570756767876, 1696.9406070787586, 5529.198266251411, 5537.224788529609, 5578.525825304854, 5625.184348269478, 5676.772929082832, 3527.805970671612, 3528.788272703646, 3542.6457354264626, 3567.9821600892087, 3611.6388361163936, 1948.8928108954, 2036.9185232590678, 2121.2787652198326, 2154.256781410411, 2215.5458131083087, 684.6884667476286, 698.9196242432083, 699.3530983839978, 703.6059806508372, 708.0759608710631, 7182.784516464514, 7184.209736928934, 7190.388816950565, 7232.819179520448, 7338.046054012998, 3181.284211052495, 3282.507623856393, 3340.6325304216516, 3356.4965255211914, 3431.987563668724, 6368.395002474757, 6403.295637479873, 6476.158099447041, 6550.934490655032, 6584.275729669733, 3511.1046683095647, 3512.5609298837644, 3540.274243780019, 3596.0650230940146, 3605.7656252343513, 3200.8239546824684, 3222.323312104484, 3223.8065716057113, 3276.3774882772195, 3329.7502687298547, 2704.5672692369126, 2734.5214587447117, 2745.890164393402, 2754.476649436601, 2783.8051336406256, 904.6381447421085, 906.7415786500816, 912.8402529557301, 921.0789210789211, 929.939553929006, 949.3022628368144, 962.5283611030544, 964.62379671928, 968.6609686609771, 1008.5763979128784, 5260.842174734764, 5282.577393808486, 5285.493634314202, 5302.045631786238, 5503.504684578407, 356.8144564826276, 357.23373364134306, 361.23057886701156, 361.2522079295832, 361.7865459378979, 4164.68764842638, 4168.562300958416, 4224.091820258659, 4247.893802654959, 4251.851185208503, 6076.361981991916, 6079.513638908877, 6204.534659900525, 6385.914394552937, 6727.428168605626, 6317.684115794192, 6345.143405640272, 6369.71336289868, 6456.386643268882, 6565.343465653396, 5189.896202075937, 5239.345081864767, 5304.045271851027, 5354.705491197944, 5440.700761458158, 4979.153543897473, 5037.974810125926, 5060.49395060491, 5074.619403544675, 5128.769205385692, 5766.538676905753, 5854.063349864001, 5856.238688970407, 5983.551233657406, 6010.669413182317, 5963.2844058713235, 5965.761369545169, 6033.969830150997, 6102.786402475892, 6163.3528479509005, 4673.252279635242, 4870.391201099863, 4905.215165573634, 4910.975445122752, 4916.582090522203, 5106.285120083117, 5166.8966620668125, 5216.556592689512, 5223.582113430993, 5371.40914499397, 4862.294967229661, 4905.48492408292, 4916.950830491649, 4941.110600092018, 4983.825566105169, 4759.381280433521, 4807.591354734747, 4842.5157484251295, 4882.5361590650255, 4967.7019378837385, 4826.758662066953, 4904.803807847647, 4918.803247870188, 4994.275830004556, 5019.774110164978, 4486.12520558488, 4527.298268768346, 4527.728336299832, 4531.13908357411, 4688.249880019181, 4413.911721765611, 4418.8453404130705, 4447.177272204653, 4497.8425755098415, 4501.572350626685], "ext.html": [399.287272219089, 422.6766523609438, 428.33394072217686, 428.4900967848261, 456.8834947088492, 28448.715512844865, 29301.267468313305, 29315.413691726153, 29362.706372936264, 29555.556666649965, 31255.84372078142, 31321.68678313216, 31355.372892542135, 32014.839925800337, 32320.0, 6834.794956151323, 6910.067140935985, 7005.929940700578, 7039.366457018893, 7110.928890711079, 6633.237177724551, 6716.8992465112815, 6776.220734615508, 6796.490263230253, 6947.5831450113155, 6783.152105986752, 6800.081988931505, 6860.0, 6916.20463646682, 7014.5440546364325, 6501.739930402779, 6745.662716864162, 6841.589504629738, 6863.965680171617, 7099.254578269285, 6596.109525214083, 6708.530402871801, 6730.798076057726, 6731.427828634572, 6750.257471678112, 28721.856390718123, 29142.708572914424, 29185.85407072972, 29196.70803291961, 29602.0, 1904.1621686458052, 1995.1520603743495, 2069.954299710276, 2345.1674655497395, 2403.639454081902, 19579.21683132673, 20289.188432462684, 20322.49193770153, 20761.377158685264, 20776.48058798527, 1785.2501949181244, 1789.2306308287432, 1791.6954117800005, 1807.3041878876595, 1850.4541160357726, 165985.0, 166948.0, 167944.0, 167958.0, 174001.0, 39504.80247598744, 41054.58945410568, 41100.58899411027, 42680.57319426828, 42884.0, 43442.565574343855, 43843.56156438459, 43903.560964389944, 43957.340639890426, 45233.0, 11746.353950532632, 11919.046476281877, 11924.284542927453, 11929.164958452826, 11962.40187990597, 8951.32865035125, 8998.415103018282, 9069.954650226706, 9081.68214112516, 9087.409318394282, 13787.51743688966, 13924.37340319688, 13978.790318145237, 14010.579682609537, 14527.055741376987, 5847.6783776891825, 6070.908936365958, 6094.695265236809, 6099.810536945253, 6101.237345331833, 657.2113463843407, 681.1961884975776, 765.7970637780993, 791.5804623549528, 810.6554714246539, 20945.58108837815, 21060.473488162614, 21080.156793728078, 21181.15275388998, 21211.0, 758.3970743259122, 803.4135081390617, 816.4448175240774, 863.9826006275292, 913.8857642794651, 10813.243072984815, 10875.673729788119, 10935.507902144423, 10990.0, 10993.074363151323, 220684.0, 228397.0, 232920.0, 233551.0, 234728.0, 38935.22129557393, 39243.41134882979, 39597.80201098976, 39609.80195099064, 40036.0, 1019.3527110284874, 1022.616518805448, 1031.0874875735028, 1031.7008067660295, 1063.7766069125416, 20472.0, 20645.17419303211, 20646.58706825885, 20763.896180519605, 21179.576408472054, 34351.48472772961, 34770.478442822874, 35018.824905875306, 36103.27793444169, 36285.0, 203401.0, 203556.0, 207123.0, 209874.0, 211325.0, 22788.4302892429, 23663.0, 23765.64351534694, 24133.758662413853, 24442.144524942254, 28271.434571308047, 28871.0, 29040.56439153372, 29918.401631966804, 30040.0, 23254.534909302056, 24761.380965476008, 25140.874295628404, 25684.229473115836, 26014.479710406064, 25021.74978250267, 25027.499450011263, 25247.0, 25514.872425638496, 25800.87099564565, 25575.360615984748, 25829.6125558113, 26197.214083577524, 26966.0, 27073.1878043659, 22940.197093101662, 22964.0, 22982.195623153777, 23306.184283549996, 23390.0, 17418.216180271666, 17714.114294284976, 17831.46505604834, 18142.0, 18151.636967260318], "prototype.html": [231.84350563369722, 234.69724055967802, 239.80935156550547, 240.90604664180972, 243.57253020948232, 4596.793144308505, 4717.221658426355, 4752.168370535155, 4767.6185905127595, 4787.257975013874, 4565.086982603484, 4708.69393489423, 4755.191617425037, 4759.3812804335475, 4759.738214398207, 3604.1169913371195, 3607.873724419646, 3617.149969757118, 3627.093226693327, 3705.685016773564, 3611.5846677632144, 3616.0959760059986, 3617.1861331200535, 3621.8913432597064, 3726.1802403471193, 3585.0, 3588.102974256436, 3624.1664417184065, 3657.76224545405, 3685.0, 3361.9495707564406, 3504.8948531544092, 3575.982120089409, 3586.8565257389673, 3613.699068335397, 2990.1179152150166, 2990.985045074761, 2995.8951436699613, 3008.5938398316166, 3109.051739219537, 4513.909721805579, 4537.31940208968, 4555.840545580889, 4607.0785842831565, 4655.557722016403, 3854.1328201154797, 3873.69010479161, 3978.3236849735613, 3982.561918189026, 4001.0397504598686, 4813.638977076734, 4905.0, 4910.975445122787, 4942.8764280893265, 5021.774020169101, 3260.934781304384, 3261.641219465857, 3262.771605987582, 3269.4768836986204, 3321.136504508845, 5187.377514698261, 5208.6093542984045, 5221.086309895791, 5252.789888404421, 5346.0, 3330.400527904952, 3334.949975750366, 3425.72594192464, 3489.842957066938, 3556.146524834073, 3544.964550354515, 3546.6453354664327, 3547.5565554305713, 3553.0, 3624.8006359649944, 4077.2660921033907, 4086.8978275542754, 4088.3254263046265, 4191.685623578243, 4209.17921005401, 4987.925181122286, 4988.700677959334, 4994.425641051253, 5020.0, 5199.194124910645, 1229.5757963502576, 1247.5633528265034, 1248.1013670157472, 1254.5107408110844, 1259.8488181418288, 801.8797180422984, 819.868820988639, 821.6302663801314, 841.9452735572169, 844.5523872347666, 4664.997025639436, 4808.807647694123, 4815.133276010351, 4822.276658501182, 4958.975205123951, 5146.614003949644, 5156.767945442464, 5159.355080614923, 5164.92252616211, 5175.171972484384, 4719.575238228507, 4721.811127554859, 4740.525947405232, 4742.952570474251, 4827.710337379768, 2674.130907455046, 2751.8073734838767, 2790.107165706954, 2790.497710412105, 2867.7419032287194, 5220.738963051832, 5238.659487133325, 5366.463353664602, 5392.946070539245, 5525.171224316385, 5297.629165958346, 5378.489043540857, 5389.841184145427, 5415.187721841755, 5461.781528738806, 5386.245925570345, 5401.540869026177, 5416.350037995545, 5475.561955043587, 5496.945030549723, 5047.965167140801, 5203.141481655636, 5247.501487358695, 5248.58011359098, 5255.054090263637, 5107.106256405188, 5109.054824857413, 5111.744412779421, 5116.616253780907, 5123.359580052494, 5386.703731294817, 5406.675599464044, 5413.729313534386, 5426.484483974016, 5592.832215033555, 3330.1008727643884, 3368.2589830237307, 3372.8819491317686, 3394.507796369463, 3452.5856897171498, 4960.206366981266, 5118.769655365592, 5143.177091665316, 5164.638475306842, 5331.4401987790725, 4998.750062496788, 5003.074431230234, 5017.724025178651, 5073.847784566469, 5185.870353241199, 5014.4484106747495, 5021.472745361684, 5066.44269130388, 5158.123119069692, 5170.353705786777, 4875.07373599015, 4885.0, 4893.290472881484, 4914.189158788903, 5050.772715227897, 4962.702237865596, 5002.849914502571, 5006.048850718352, 5066.36670416198, 5111.948880511147, 4917.778699958439, 4919.532644398776, 4936.753162341796, 4938.209886418156, 5118.513741194581], "yui.html": [544.7303584725562, 549.2694716027684, 554.0968221798468, 556.4880310114692, 593.193725107049, 9822.116009559139, 9927.0, 9976.650817221398, 10139.847902281463, 10195.031472010165, 9674.951625241863, 9797.0, 9905.504724763769, 10015.298929074968, 10019.298649094566, 523.5471317310537, 647.4140902483249, 661.0744957060107, 664.0570390046146, 678.0338018323869, 522.049869237987, 631.3181763695221, 650.7624716978316, 669.0866966590593, 672.7981605518349, 666.2404858461358, 679.4700133895544, 681.400367676444, 698.9755358562452, 709.464354412418, 676.9323067693241, 677.1231255524108, 677.8102131403215, 685.715428097339, 694.9756758513453, 499.0791988780694, 508.01445196319025, 513.8997895410397, 516.1174391790044, 523.3458177278402, 10198.082172604501, 10343.224258180591, 10450.268481206318, 10458.320209186379, 10564.630237941712, 8540.359473039547, 8627.180417860292, 8692.348073894484, 9046.3667543272, 9409.341346105775, 6924.93075069253, 7077.3984211342095, 7177.748778792769, 7313.817154571125, 7381.335679788791, 2466.0382450844186, 2481.10680155144, 2504.161106029482, 2528.7724104830468, 2567.345326941637, 37023.444648330296, 37139.25721485555, 38165.0, 38270.61729382698, 38478.615213847785, 6546.509011824132, 6639.302873198341, 6705.329467053353, 6719.764808231688, 6898.0, 13636.250006249553, 13675.0, 13765.518206862711, 13941.512047078304, 14402.495912643008, 5295.629305948623, 5299.4700529946695, 5354.303940487712, 5405.135178371442, 5493.2034854945805, 2765.3916138449913, 2778.374865655252, 2841.7300356466103, 2922.006517783964, 2942.6321709786275, 2130.4567335329393, 2168.0785666091847, 2168.132746901221, 2168.360333701562, 2242.887855607213, 304.4747810027729, 305.08170407074863, 310.4024752351714, 312.259943932876, 317.1136672998973, 349.09758274859263, 384.29481900712506, 395.39109770952984, 423.6610711430843, 475.98614950155945, 5278.788848446019, 5921.792737254175, 6007.309159446632, 6019.337872833985, 6138.662373569497, 388.72400595577454, 404.88460788675087, 415.7983378061638, 442.9899828391273, 446.83020452228595, 2664.3605534671537, 2829.688734239232, 2836.546152615572, 2913.2716820794803, 2922.8369062987263, 42553.0, 43101.982861199416, 43765.0, 45084.323735144, 45336.0, 35643.643563564554, 36773.0, 37563.812180939465, 37639.4354084689, 38383.61616383801, 34098.829505852314, 35175.4723679145, 35299.82350088233, 36196.0, 36227.63772362243, 6141.447269745744, 6191.5665903388135, 6219.502439804714, 6297.275813281532, 6303.905441418291, 25712.614310785728, 26340.736592633828, 26777.598336024585, 26965.86517067402, 27365.0, 30887.845560772053, 31647.050588482383, 31751.364972700878, 34528.82735586306, 36397.45403818892, 5480.725963701879, 5487.6158668894395, 5504.4495550444635, 5744.856378590569, 5799.5070419014855, 8093.757187284391, 8131.7560473185895, 8467.703630372907, 8750.124987501453, 8763.474191548528, 7555.73554925575, 7837.921620783719, 7860.096088949844, 7935.484193527403, 8375.21769115876, 7740.92259077402, 7831.0, 7986.640601172845, 8061.193880612126, 8404.159584041547, 7311.0, 7352.338289553966, 7633.69465221385, 7732.188120247518, 8113.310368618733, 6666.799996000128, 6793.252742198453, 6870.0, 6890.793276201722, 6947.617881016593, 6421.743130274736, 6467.579607325509, 6514.446272066738, 7024.438044956493, 7058.11773528309]}, "summary": {"lowerIsBetter": false, "suite": 5025.7852925322295, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5779.891008386656, "unit": "ms", "value": 5779.891008386656}, "dojo.html": {"lowerIsBetter": false, "filtered": 3902.128411013243, "unit": "ms", "value": 3902.128411013243}, "mootools.html": {"lowerIsBetter": false, "filtered": 3171.7123045562425, "unit": "ms", "value": 3171.7123045562425}, "ext.html": {"lowerIsBetter": false, "filtered": 13390.17035799733, "unit": "ms", "value": 13390.17035799733}, "prototype.html": {"lowerIsBetter": false, "filtered": 3745.5257889190475, "unit": "ms", "value": 3745.5257889190475}, "yui.html": {"lowerIsBetter": false, "filtered": 4491.1726482360955, "unit": "ms", "value": 4491.1726482360955}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0066.e"}, "testrun": {"date": 1447804357, "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": "20151117140619", "branch": "Fx-Team", "revision": "55585709276f4b9c00375a1ec8075198e6d8960f"}}, {"talos_counters": {}, "results": {"audio-dft": [211.0, 218.0, 230.0, 233.0, 234.0, 233.0, 233.0, 224.0, 219.0, 220.0], "ai-astar": [139.0, 138.0, 149.0, 157.0, 155.0, 171.0, 154.0, 156.0, 157.0, 155.0], "imaging-gaussian-blur": [165.0, 165.0, 174.0, 166.0, 166.0, 167.0, 166.0, 166.0, 174.0, 175.0], "audio-beat-detection": [204.0, 177.0, 211.0, 225.0, 184.0, 208.0, 207.0, 180.0, 224.0, 186.0], "json-stringify-tinderbox": [91.0, 89.0, 94.0, 95.0, 98.0, 100.0, 101.0, 101.0, 102.0, 102.0], "stanford-crypto-pbkdf2": [187.0, 217.0, 224.0, 226.0, 225.0, 216.0, 223.0, 225.0, 223.0, 222.0], "json-parse-financial": [81.0, 83.0, 83.0, 87.0, 88.0, 86.0, 92.0, 93.0, 94.0, 97.0], "stanford-crypto-sha256-iterative": [92.0, 93.0, 97.0, 98.0, 97.0, 106.0, 111.0, 108.0, 113.0, 117.0], "audio-fft": [97.0, 95.0, 105.0, 153.0, 95.0, 101.0, 101.0, 101.0, 134.0, 95.0], "imaging-darkroom": [183.0, 182.0, 183.0, 184.0, 183.0, 183.0, 182.0, 182.0, 183.0, 182.0], "stanford-crypto-ccm": [165.0, 167.0, 179.0, 181.0, 191.0, 180.0, 179.0, 180.0, 186.0, 186.0], "audio-oscillator": [115.0, 114.0, 166.0, 122.0, 126.0, 129.0, 166.0, 126.0, 127.0, 171.0], "stanford-crypto-aes": [111.0, 118.0, 119.0, 124.0, 124.0, 123.0, 124.0, 126.0, 136.0, 133.0], "imaging-desaturate": [141.0, 136.0, 144.0, 152.0, 135.0, 136.0, 138.0, 156.0, 157.0, 156.0]}, "summary": {"lowerIsBetter": true, "suite": 2130.2, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 107.7, "unit": "ms", "value": 107.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 218.8, "unit": "ms", "value": 218.8}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 200.6, "unit": "ms", "value": 200.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 179.4, "unit": "ms", "value": 179.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 182.7, "unit": "ms", "value": 182.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 88.4, "unit": "ms", "value": 88.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 136.2, "unit": "ms", "value": 136.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 153.1, "unit": "ms", "value": 153.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 225.5, "unit": "ms", "value": 225.5}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 103.2, "unit": "ms", "value": 103.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 97.3, "unit": "ms", "value": 97.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 168.4, "unit": "ms", "value": 168.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 123.8, "unit": "ms", "value": 123.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 145.1, "unit": "ms", "value": 145.1}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0066.e"}, "testrun": {"date": 1447804357, "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": "20151117140619", "branch": "Fx-Team", "revision": "55585709276f4b9c00375a1ec8075198e6d8960f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [267.8093197643278], "Encrypt": [434.97172683775557], "NavierStokes": [7590.909090909091], "Decrypt": [7820.3125], "Splay": [976.6081871345029], "Richards": [220.99447513812154], "RegExp": [39784.313725490196], "Earley": [1074.1138560687432], "Boyer": [17293.103448275862], "RayTrace": [1622.3662884927066]}, "summary": {"lowerIsBetter": false, "suite": 14291.612229572047, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 246.88461200000003, "unit": "score", "value": 246.88461200000003}, "Encrypt": {"lowerIsBetter": false, "filtered": 611.9501189999999, "unit": "score", "value": 611.9501189999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 195.49700598802386, "unit": "score", "value": 195.49700598802386}, "Decrypt": {"lowerIsBetter": false, "filtered": 34.03713086913086, "unit": "score", "value": 34.03713086913086}, "Splay": {"lowerIsBetter": false, "filtered": 83.44288023952096, "unit": "score", "value": 83.44288023952096}, "RegExp": {"lowerIsBetter": false, "filtered": 22.898095120749154, "unit": "score", "value": 22.898095120749154}, "Richards": {"lowerIsBetter": false, "filtered": 159.74155, "unit": "score", "value": 159.74155}, "Earley": {"lowerIsBetter": false, "filtered": 620.4770530000002, "unit": "score", "value": 620.4770530000002}, "Boyer": {"lowerIsBetter": false, "filtered": 38.53923629112663, "unit": "score", "value": 38.53923629112663}, "RayTrace": {"lowerIsBetter": false, "filtered": 456.1170959040959, "unit": "score", "value": 456.1170959040959}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0066.e"}, "testrun": {"date": 1447804357, "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": "20151117140619", "branch": "Fx-Team", "revision": "55585709276f4b9c00375a1ec8075198e6d8960f"}}] 16:13:00 INFO - RETURN: dromaeo_css: 5025.79 16:13:00 INFO - RETURN: kraken: 2130.20 16:13:00 INFO - RETURN: v8_7: 14291.61 16:13:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "14291.61"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "2130.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5025.79"}}} 16:13:00 INFO - Return code: 0 16:13:00 INFO - # TBPL SUCCESS # 16:13:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:13:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:13:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:13:00 INFO - 2015-11-17 16:13:00.303 screenresolution[1672:10650] starting screenresolution argv=screenresolution get 16:13:00 INFO - 2015-11-17 16:13:00.307 screenresolution[1672:10650] Display 0: 1600x1200x32@60 16:13:00 INFO - 2015-11-17 16:13:00.315 screenresolution[1673:10653] starting screenresolution argv=screenresolution list 16:13:00 INFO - Available Modes on Display 0 16:13:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:13:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:13:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:13:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:13:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:13:00 INFO - Intel HD Graphics 3000: 16:13:00 INFO - Chipset Model: Intel HD Graphics 3000 16:13:00 INFO - Type: GPU 16:13:00 INFO - Bus: Built-In 16:13:00 INFO - VRAM (Total): 512 MB 16:13:00 INFO - VRAM (Dynamic, Max): 10 16:13:00 INFO - Vendor: Intel (0x8086) 16:13:00 INFO - Device ID: 0x0116 16:13:00 INFO - Revision ID: 0x0009 16:13:00 INFO - Displays: 16:13:00 INFO - Display: 16:13:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:13:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:13:00 INFO - Display Serial Number: 1600x1200 60 16:13:00 INFO - Main Display: Yes 16:13:00 INFO - Mirror: Off 16:13:00 INFO - Online: Yes 16:13:00 INFO - Rotation: Supported 16:13:00 INFO - Return code: 0 16:13:00 INFO - Running post-action listener: _resource_record_post_action 16:13:00 INFO - Running post-run listener: _resource_record_post_run 16:13:01 INFO - Total resource usage - Wall time: 1271s; CPU: 30.0%; Read bytes: 40895488; Write bytes: 701879296; Read time: 5078; Write time: 43130 16:13:01 INFO - install - Wall time: 48s; CPU: 30.0%; Read bytes: 340357632; Write bytes: 334292992; Read time: 41641; Write time: 3435 16:13:01 INFO - run-tests - Wall time: 1224s; CPU: 30.0%; Read bytes: 38945792; Write bytes: 356383744; Read time: 4733; Write time: 38942 16:13:01 INFO - Running post-run listener: _upload_blobber_files 16:13:01 INFO - Blob upload gear active. 16:13:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:13:01 INFO - Copying logs to upload dir... 16:13:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1336.337829 ========= master_lag: 1.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 17 secs) (at 2015-11-17 16:13:02.748271) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 16:13:02.749491) ========= 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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011515 build_url: 'https://queue.taskcluster.net/v1/task/CSprtG9ATT-c_d2BKs_AyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.76 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 16:13:03.518064) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 16:13:03.522473) ========= 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.cSTQ2Cf1AF/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.6gxHWRYeMB/Listeners TMPDIR=/var/folders/tf/7nrwnv995j36_qb9gdbgjc7m00000w/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.005920 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 16:13:03.567770) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 16:13:03.568073) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 16:13:03.572741) ========= ========= Total master_lag: 1.96 =========