builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0027 starttime: 1447747047.34 results: success (0) buildid: 20151116221703 builduid: c5b9d883148e4ca28de6cb37afc78bc8 revision: 996fabe1edaa17ae416baf84089baa2c50076707 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:27.343134) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:27.343560) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:27.343875) ========= 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.U3DaJEedFW/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.fiK7OD8D79/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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.005826 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:27.440244) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:27.440569) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:27.603611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:27.603901) ========= 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.U3DaJEedFW/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.fiK7OD8D79/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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.005280 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:27.700566) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:27.700893) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:27.701301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:27.701615) ========= 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.U3DaJEedFW/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.fiK7OD8D79/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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-16 23:57:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.102, 63.245.215.25, ... Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-16 23:57:28 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.210883 ========= master_lag: 0.60 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:28.510811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:28.511137) ========= 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.U3DaJEedFW/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.fiK7OD8D79/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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.019465 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:28.601321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:28.602253) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 996fabe1edaa17ae416baf84089baa2c50076707 --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 996fabe1edaa17ae416baf84089baa2c50076707 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.U3DaJEedFW/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.fiK7OD8D79/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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-16 23:57:28,687 truncating revision to first 12 chars 2015-11-16 23:57:28,688 Setting DEBUG logging. 2015-11-16 23:57:28,688 attempt 1/10 2015-11-16 23:57:28,688 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/996fabe1edaa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 23:57:28,995 unpacking tar archive at: fx-team-996fabe1edaa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.569393 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:29.467938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:29.468260) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:29.508900) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:29.509227) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 23:57:29.509651) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-16 23:57:29.509982) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.U3DaJEedFW/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.fiK7OD8D79/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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 23:57:29 INFO - MultiFileLogger online at 20151116 23:57:29 in /builds/slave/test 23:57:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:57:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:57:29 INFO - {'append_to_log': False, 23:57:29 INFO - 'base_work_dir': '/builds/slave/test', 23:57:29 INFO - 'blob_upload_branch': 'Fx-Team', 23:57:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:57:29 INFO - 'branch': 'Fx-Team', 23:57:29 INFO - 'buildbot_json_path': 'buildprops.json', 23:57:29 INFO - 'config_files': ('talos/mac_config.py',), 23:57:29 INFO - 'default_actions': ('clobber', 23:57:29 INFO - 'read-buildbot-config', 23:57:29 INFO - 'download-and-extract', 23:57:29 INFO - 'populate-webroot', 23:57:29 INFO - 'create-virtualenv', 23:57:29 INFO - 'install', 23:57:29 INFO - 'run-tests'), 23:57:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:57:29 INFO - 'download_minidump_stackwalk': True, 23:57:29 INFO - 'download_symbols': 'ondemand', 23:57:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:57:29 INFO - 'tooltool.py': '/tools/tooltool.py', 23:57:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:57:29 INFO - '/tools/misc-python/virtualenv.py')}, 23:57:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:57:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:57:29 INFO - 'installer_path': 'installer.exe', 23:57:29 INFO - 'log_level': 'info', 23:57:29 INFO - 'log_name': 'talos', 23:57:29 INFO - 'log_to_console': True, 23:57:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:57:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:57:29 INFO - 'opt_config_files': (), 23:57:29 INFO - 'pip_index': False, 23:57:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:57:29 INFO - 'cmd': ('bash', 23:57:29 INFO - '-c', 23:57:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:57:29 INFO - 'enabled': True, 23:57:29 INFO - 'halt_on_failure': False, 23:57:29 INFO - 'name': 'check_screen_resolution'},), 23:57:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:57:29 INFO - 'cmd': ('bash', 23:57:29 INFO - '-c', 23:57:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:57:29 INFO - 'enabled': True, 23:57:29 INFO - 'halt_on_failure': False, 23:57:29 INFO - 'name': 'check_screen_resolution'},), 23:57:29 INFO - 'run_cmd_checks_enabled': True, 23:57:29 INFO - 'sps_profile': False, 23:57:29 INFO - 'sps_profile_interval': 0, 23:57:29 INFO - 'suite': 'dromaeojs', 23:57:29 INFO - 'system_bits': '64', 23:57:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:57:29 INFO - 'title': 't-yosemite-r5-0027', 23:57:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:57:29 INFO - 'use_talos_json': True, 23:57:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:57:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:57:29 INFO - 'work_dir': 'build'} 23:57:29 INFO - ##### 23:57:29 INFO - ##### Running clobber step. 23:57:29 INFO - ##### 23:57:29 INFO - Running pre-action listener: _resource_record_pre_action 23:57:29 INFO - Running main action method: clobber 23:57:29 INFO - rmtree: /builds/slave/test/build 23:57:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:57:31 INFO - Running post-action listener: _resource_record_post_action 23:57:31 INFO - ##### 23:57:31 INFO - ##### Running read-buildbot-config step. 23:57:31 INFO - ##### 23:57:31 INFO - Running pre-action listener: _resource_record_pre_action 23:57:31 INFO - Running main action method: read_buildbot_config 23:57:31 INFO - Using buildbot properties: 23:57:31 INFO - { 23:57:31 INFO - "properties": { 23:57:31 INFO - "buildnumber": 1347, 23:57:31 INFO - "product": "firefox", 23:57:31 INFO - "script_repo_revision": "production", 23:57:31 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 23:57:31 INFO - "repository": "", 23:57:31 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 23:57:31 INFO - "buildid": "20151116221703", 23:57:31 INFO - "slavename": "t-yosemite-r5-0027", 23:57:31 INFO - "pgo_build": "False", 23:57:31 INFO - "basedir": "/builds/slave/test", 23:57:31 INFO - "project": "", 23:57:31 INFO - "platform": "yosemite", 23:57:31 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 23:57:31 INFO - "slavebuilddir": "test", 23:57:31 INFO - "scheduler": "tests-fx-team-macosx64-talos", 23:57:31 INFO - "branch": "fx-team", 23:57:31 INFO - "repo_path": "integration/fx-team", 23:57:31 INFO - "stage_platform": "macosx64", 23:57:31 INFO - "builduid": "c5b9d883148e4ca28de6cb37afc78bc8", 23:57:31 INFO - "revision": "996fabe1edaa17ae416baf84089baa2c50076707" 23:57:31 INFO - }, 23:57:31 INFO - "sourcestamp": { 23:57:31 INFO - "repository": "", 23:57:31 INFO - "hasPatch": false, 23:57:31 INFO - "project": "", 23:57:31 INFO - "branch": "fx-team-macosx64-talos", 23:57:31 INFO - "changes": [ 23:57:31 INFO - { 23:57:31 INFO - "category": null, 23:57:31 INFO - "files": [ 23:57:31 INFO - { 23:57:31 INFO - "url": null, 23:57:31 INFO - "name": "https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 23:57:31 INFO - } 23:57:31 INFO - ], 23:57:31 INFO - "repository": "", 23:57:31 INFO - "rev": "996fabe1edaa17ae416baf84089baa2c50076707", 23:57:31 INFO - "who": "kcambridge@mozilla.com", 23:57:31 INFO - "when": 1447746999, 23:57:31 INFO - "number": 6670444, 23:57:31 INFO - "comments": "Bug 1224738 - Fix alternate action index getter name on OS X. r=MattN", 23:57:31 INFO - "project": "", 23:57:31 INFO - "at": "Mon 16 Nov 2015 23:56:39", 23:57:31 INFO - "branch": "fx-team-macosx64-talos", 23:57:31 INFO - "revlink": "", 23:57:31 INFO - "properties": [ 23:57:31 INFO - [ 23:57:31 INFO - "buildid", 23:57:31 INFO - "20151116221703", 23:57:31 INFO - "Change" 23:57:31 INFO - ], 23:57:31 INFO - [ 23:57:31 INFO - "builduid", 23:57:31 INFO - "c5b9d883148e4ca28de6cb37afc78bc8", 23:57:31 INFO - "Change" 23:57:31 INFO - ], 23:57:31 INFO - [ 23:57:31 INFO - "pgo_build", 23:57:31 INFO - "False", 23:57:31 INFO - "Change" 23:57:31 INFO - ] 23:57:31 INFO - ], 23:57:31 INFO - "revision": "996fabe1edaa17ae416baf84089baa2c50076707" 23:57:31 INFO - } 23:57:31 INFO - ], 23:57:31 INFO - "revision": "996fabe1edaa17ae416baf84089baa2c50076707" 23:57:31 INFO - } 23:57:31 INFO - } 23:57:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 23:57:31 INFO - Running post-action listener: _resource_record_post_action 23:57:31 INFO - ##### 23:57:31 INFO - ##### Running download-and-extract step. 23:57:31 INFO - ##### 23:57:31 INFO - Running pre-action listener: _resource_record_pre_action 23:57:31 INFO - Running main action method: download_and_extract 23:57:31 INFO - mkdir: /builds/slave/test/build/tests 23:57:31 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')]} 23:57:31 INFO - https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/test_packages.json 23:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/test_packages.json 23:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 23:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 23:57:47 INFO - Downloaded 1149 bytes. 23:57:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 23:57:47 INFO - Using the following test package requirements: 23:57:47 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:57:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:47 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 23:57:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:47 INFO - u'jsshell-mac.zip'], 23:57:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:47 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 23:57:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:57:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:47 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 23:57:47 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:47 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 23:57:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:47 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 23:57:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 23:57:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 23:57:47 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 23:57:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:57:47 INFO - https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:57:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/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 23:57:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/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 23:57:48 INFO - Downloaded 17460765 bytes. 23:57:48 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 23:57:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:57:53 INFO - Return code: 0 23:57:53 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 23:57:53 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')]} 23:57:53 INFO - https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/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 23:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/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 23:57:55 INFO - Downloaded 17460765 bytes. 23:57:55 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 23:57:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 23:57:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 23:58:02 INFO - Return code: 0 23:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:02 INFO - https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:58:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:58:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:58:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/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 23:58:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/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 23:58:03 INFO - Downloaded 11131693 bytes. 23:58:03 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 23:58:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 23:58:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 23:58:04 INFO - Return code: 0 23:58: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')]} 23:58:04 INFO - https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:58:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:58:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:58:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 23:58:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bc12LPlBTgWw017NDBOmpQ/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 23:58:07 INFO - Downloaded 108756991 bytes. 23:58:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:58:07 INFO - mkdir: /builds/slave/test/properties 23:58:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:58:07 INFO - Writing to file /builds/slave/test/properties/build_url 23:58:07 INFO - Contents: 23:58:07 INFO - build_url:https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 23:58:07 INFO - Running post-action listener: _resource_record_post_action 23:58:07 INFO - Running post-action listener: set_extra_try_arguments 23:58:07 INFO - ##### 23:58:07 INFO - ##### Running populate-webroot step. 23:58:07 INFO - ##### 23:58:07 INFO - Running pre-action listener: _resource_record_pre_action 23:58:07 INFO - Running main action method: populate_webroot 23:58:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:58:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:58:07 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 23:58:07 INFO - '../fennec_ids.txt'], 23:58:07 INFO - 'tests': ['tcheck2']}, 23:58:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:58:07 INFO - '--tppagecycles', 23:58:07 INFO - '7'], 23:58:07 INFO - 'tests': ['tsvgm']}}, 23:58:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:58:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:58:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:58:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:58:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:58:07 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:58:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:58:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:07 INFO - 'talos_options': ['--e10s'], 23:58:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:58:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:07 INFO - 'tests': ['damp', 'tps']}, 23:58:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:07 INFO - 'talos_options': ['--e10s'], 23:58:07 INFO - 'tests': ['damp', 'tps']}, 23:58:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:58:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:58:07 INFO - 'other': {'tests': ['a11yr', 23:58:07 INFO - 'ts_paint', 23:58:07 INFO - 'tpaint', 23:58:07 INFO - 'sessionrestore', 23:58:07 INFO - 'sessionrestore_no_auto_restore']}, 23:58:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:58:07 INFO - 'tests': ['a11yr', 23:58:07 INFO - 'ts_paint', 23:58:07 INFO - 'tpaint', 23:58:07 INFO - 'sessionrestore', 23:58:07 INFO - 'sessionrestore_no_auto_restore']}, 23:58:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:58:07 INFO - 'tests': ['a11yr', 23:58:07 INFO - 'ts_paint', 23:58:07 INFO - 'tpaint', 23:58:07 INFO - 'sessionrestore', 23:58:07 INFO - 'sessionrestore_no_auto_restore']}, 23:58:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:58:07 INFO - 'tests': ['a11yr', 23:58:07 INFO - 'ts_paint', 23:58:07 INFO - 'tpaint', 23:58:07 INFO - 'sessionrestore', 23:58:07 INFO - 'sessionrestore_no_auto_restore']}, 23:58:07 INFO - 'other_l64': {'tests': ['a11yr', 23:58:07 INFO - 'ts_paint', 23:58:07 INFO - 'tpaint', 23:58:07 INFO - 'sessionrestore', 23:58:07 INFO - 'sessionrestore_no_auto_restore']}, 23:58:07 INFO - 'other_nol64': {'tests': ['a11yr', 23:58:07 INFO - 'ts_paint', 23:58:07 INFO - 'tpaint', 23:58:07 INFO - 'sessionrestore', 23:58:07 INFO - 'sessionrestore_no_auto_restore']}, 23:58:07 INFO - 'svgr': {'tests': ['tsvgx', 23:58:07 INFO - 'tsvgr_opacity', 23:58:07 INFO - 'tart', 23:58:07 INFO - 'tscrollx', 23:58:07 INFO - 'cart']}, 23:58:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:58:07 INFO - 'tests': ['tsvgx', 23:58:07 INFO - 'tsvgr_opacity', 23:58:07 INFO - 'tart', 23:58:07 INFO - 'tscrollx', 23:58:07 INFO - 'cart']}, 23:58:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:07 INFO - 'tests': ['tp5o']}, 23:58:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:07 INFO - 'talos_options': ['--e10s'], 23:58:07 INFO - 'tests': ['tp5o']}, 23:58:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:07 INFO - 'talos_options': ['--xperf_path', 23:58:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:58:07 INFO - 'tests': ['tp5n']}, 23:58:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:58:07 INFO - 'talos_options': ['--e10s', 23:58:07 INFO - '--xperf_path', 23:58:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:58:07 INFO - 'tests': ['tp5n']}}, 23:58:07 INFO - 'talos.zip': {'path': '', 23:58:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:58:07 INFO - Running post-action listener: _resource_record_post_action 23:58:07 INFO - ##### 23:58:07 INFO - ##### Running create-virtualenv step. 23:58:07 INFO - ##### 23:58:07 INFO - Running pre-action listener: _resource_record_pre_action 23:58:07 INFO - Running main action method: create_virtualenv 23:58:07 INFO - Creating virtualenv /builds/slave/test/build/venv 23:58:07 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 23:58:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:58:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:58:07 INFO - Using real prefix '/tools/python27' 23:58:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:58:08 INFO - Installing distribute.............................................................................................................................................................................................done. 23:58:11 INFO - Installing pip.................done. 23:58:11 INFO - Return code: 0 23:58:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:11 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 0x10996c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109949228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83dae3e0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988f9f0>, '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 0x1095efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098838c8>, '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.U3DaJEedFW/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.fiK7OD8D79/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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 23:58:11 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 23:58:11 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 23:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U3DaJEedFW/Render', 23:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:11 INFO - 'HOME': '/Users/cltbld', 23:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:11 INFO - 'LOGNAME': 'cltbld', 23:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:11 INFO - 'MOZ_NO_REMOTE': '1', 23:58:11 INFO - 'NO_EM_RESTART': '1', 23:58:11 INFO - 'PAGER': '/bin/cat', 23:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:11 INFO - 'PWD': '/builds/slave/test', 23:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:11 INFO - 'SHELL': '/bin/bash', 23:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fiK7OD8D79/Listeners', 23:58:11 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 23:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:11 INFO - 'USER': 'cltbld', 23:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:11 INFO - 'XPC_FLAGS': '0x0', 23:58:11 INFO - 'XPC_SERVICE_NAME': '0', 23:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:11 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 23:58:11 INFO - Cleaning up... 23:58:11 INFO - Return code: 0 23:58:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:11 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 0x10996c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109949228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83dae3e0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988f9f0>, '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 0x1095efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098838c8>, '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.U3DaJEedFW/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.fiK7OD8D79/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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 23:58:11 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 23:58:11 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 23:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U3DaJEedFW/Render', 23:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:11 INFO - 'HOME': '/Users/cltbld', 23:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:11 INFO - 'LOGNAME': 'cltbld', 23:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:11 INFO - 'MOZ_NO_REMOTE': '1', 23:58:11 INFO - 'NO_EM_RESTART': '1', 23:58:11 INFO - 'PAGER': '/bin/cat', 23:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:11 INFO - 'PWD': '/builds/slave/test', 23:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:11 INFO - 'SHELL': '/bin/bash', 23:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fiK7OD8D79/Listeners', 23:58:11 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 23:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:11 INFO - 'USER': 'cltbld', 23:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:11 INFO - 'XPC_FLAGS': '0x0', 23:58:11 INFO - 'XPC_SERVICE_NAME': '0', 23:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:12 INFO - Downloading/unpacking psutil>=0.7.1 23:58:12 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 23:58:12 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 23:58:12 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 23:58:12 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 23:58:12 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 23:58:12 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 23:58:14 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 23:58:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:58:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:58:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:58:14 INFO - Installing collected packages: psutil 23:58:14 INFO - Running setup.py install for psutil 23:58:14 INFO - building 'psutil._psutil_osx' extension 23:58:14 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 23:58:15 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 23:58:15 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 23:58:15 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 23:58:15 INFO - building 'psutil._psutil_posix' extension 23:58:15 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 23:58:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:58:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:58:15 INFO - ^ 23:58:15 INFO - 1 warning generated. 23:58:15 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 23:58:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:58:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:58:15 INFO - Successfully installed psutil 23:58:15 INFO - Cleaning up... 23:58:15 INFO - Return code: 0 23:58:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:58:15 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')]} 23:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:15 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')]} 23:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:15 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 0x10996c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109949228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83dae3e0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988f9f0>, '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 0x1095efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098838c8>, '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.U3DaJEedFW/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.fiK7OD8D79/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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 23:58:15 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 23:58:15 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 23:58:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U3DaJEedFW/Render', 23:58:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:15 INFO - 'HOME': '/Users/cltbld', 23:58:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:15 INFO - 'LOGNAME': 'cltbld', 23:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:15 INFO - 'MOZ_NO_REMOTE': '1', 23:58:15 INFO - 'NO_EM_RESTART': '1', 23:58:15 INFO - 'PAGER': '/bin/cat', 23:58:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:15 INFO - 'PWD': '/builds/slave/test', 23:58:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:15 INFO - 'SHELL': '/bin/bash', 23:58:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fiK7OD8D79/Listeners', 23:58:15 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 23:58:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:15 INFO - 'USER': 'cltbld', 23:58:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:15 INFO - 'XPC_FLAGS': '0x0', 23:58:15 INFO - 'XPC_SERVICE_NAME': '0', 23:58:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:58:15 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 23:58:15 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 23:58:15 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 23:58:15 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 23:58:15 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 23:58:15 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 23:58:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:58:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:58:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:58:18 INFO - Installing collected packages: mozsystemmonitor 23:58:18 INFO - Running setup.py install for mozsystemmonitor 23:58:18 INFO - Successfully installed mozsystemmonitor 23:58:18 INFO - Cleaning up... 23:58:18 INFO - Return code: 0 23:58:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:18 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 0x10996c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109949228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83dae3e0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988f9f0>, '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 0x1095efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098838c8>, '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.U3DaJEedFW/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.fiK7OD8D79/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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 23:58:18 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 23:58:18 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 23:58:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U3DaJEedFW/Render', 23:58:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:18 INFO - 'HOME': '/Users/cltbld', 23:58:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:18 INFO - 'LOGNAME': 'cltbld', 23:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:18 INFO - 'MOZ_NO_REMOTE': '1', 23:58:18 INFO - 'NO_EM_RESTART': '1', 23:58:18 INFO - 'PAGER': '/bin/cat', 23:58:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:18 INFO - 'PWD': '/builds/slave/test', 23:58:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:18 INFO - 'SHELL': '/bin/bash', 23:58:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fiK7OD8D79/Listeners', 23:58:18 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 23:58:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:18 INFO - 'USER': 'cltbld', 23:58:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:18 INFO - 'XPC_FLAGS': '0x0', 23:58:18 INFO - 'XPC_SERVICE_NAME': '0', 23:58:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:18 INFO - Downloading/unpacking blobuploader==1.2.4 23:58: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 23:58: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 23:58: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 23:58: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 23:58: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 23:58: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 23:58:21 INFO - Downloading blobuploader-1.2.4.tar.gz 23:58:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:58:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:58:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:58:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:58:22 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 23:58:22 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 23:58:22 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 23:58:22 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 23:58:22 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 23:58:22 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 23:58:22 INFO - Downloading docopt-0.6.1.tar.gz 23:58:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:58:22 INFO - Installing collected packages: blobuploader, requests, docopt 23:58:22 INFO - Running setup.py install for blobuploader 23:58:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:58:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:58:22 INFO - Running setup.py install for requests 23:58:23 INFO - Running setup.py install for docopt 23:58:23 INFO - Successfully installed blobuploader requests docopt 23:58:23 INFO - Cleaning up... 23:58:23 INFO - Return code: 0 23:58:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58:23 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')]} 23:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:23 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')]} 23:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:23 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 0x10996c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109949228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83dae3e0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988f9f0>, '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 0x1095efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098838c8>, '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.U3DaJEedFW/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.fiK7OD8D79/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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 23:58:23 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 23:58:23 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 23:58:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U3DaJEedFW/Render', 23:58:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:23 INFO - 'HOME': '/Users/cltbld', 23:58:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:23 INFO - 'LOGNAME': 'cltbld', 23:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:23 INFO - 'MOZ_NO_REMOTE': '1', 23:58:23 INFO - 'NO_EM_RESTART': '1', 23:58:23 INFO - 'PAGER': '/bin/cat', 23:58:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:23 INFO - 'PWD': '/builds/slave/test', 23:58:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:23 INFO - 'SHELL': '/bin/bash', 23:58:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fiK7OD8D79/Listeners', 23:58:23 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 23:58:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:23 INFO - 'USER': 'cltbld', 23:58:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:23 INFO - 'XPC_FLAGS': '0x0', 23:58:23 INFO - 'XPC_SERVICE_NAME': '0', 23:58:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:58:23 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-e7Z3aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:58:24 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-Gnl7YQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:58:24 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-Z6Sn_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:58:24 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-9jaiiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:58:24 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-flXPyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:58:24 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-ORllil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:58:24 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-tyEeKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:58:24 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-6eaxTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:58:24 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-oYwAuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:58:25 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-ZBtWEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:58:25 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-1IGmf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:58:25 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-K52xHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:58:25 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-qsDZey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:58:25 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-7jbI0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:25 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-mN7pXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:58:25 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-0wg434-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:58:25 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-Aq04cT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:58:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:58:26 INFO - Running setup.py install for manifestparser 23:58:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:58:26 INFO - Running setup.py install for mozcrash 23:58:26 INFO - Running setup.py install for mozdebug 23:58:26 INFO - Running setup.py install for mozdevice 23:58:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:58:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:58:26 INFO - Running setup.py install for mozfile 23:58:26 INFO - Running setup.py install for mozhttpd 23:58:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:58:27 INFO - Running setup.py install for mozinfo 23:58:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:58:27 INFO - Running setup.py install for mozInstall 23:58:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:58:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:58:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:58:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:58:27 INFO - Running setup.py install for mozleak 23:58:27 INFO - Running setup.py install for mozlog 23:58:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:58:27 INFO - Running setup.py install for moznetwork 23:58:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:58:27 INFO - Running setup.py install for mozprocess 23:58:28 INFO - Running setup.py install for mozprofile 23:58:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:58:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:58:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:58:28 INFO - Running setup.py install for mozrunner 23:58:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:58:28 INFO - Running setup.py install for mozscreenshot 23:58:28 INFO - Running setup.py install for moztest 23:58:28 INFO - Running setup.py install for mozversion 23:58:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:58:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:58:29 INFO - Cleaning up... 23:58:29 INFO - Return code: 0 23:58:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10996c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109949228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83dae3e0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988f9f0>, '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 0x1095efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098838c8>, '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.U3DaJEedFW/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.fiK7OD8D79/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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 23:58:29 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 23:58:29 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 23:58:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U3DaJEedFW/Render', 23:58:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:29 INFO - 'HOME': '/Users/cltbld', 23:58:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:29 INFO - 'LOGNAME': 'cltbld', 23:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:29 INFO - 'MOZ_NO_REMOTE': '1', 23:58:29 INFO - 'NO_EM_RESTART': '1', 23:58:29 INFO - 'PAGER': '/bin/cat', 23:58:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:29 INFO - 'PWD': '/builds/slave/test', 23:58:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:29 INFO - 'SHELL': '/bin/bash', 23:58:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fiK7OD8D79/Listeners', 23:58:29 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 23:58:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:29 INFO - 'USER': 'cltbld', 23:58:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:29 INFO - 'XPC_FLAGS': '0x0', 23:58:29 INFO - 'XPC_SERVICE_NAME': '0', 23:58:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:58:29 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-IJS9yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:58:29 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)) 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:58:29 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-9ZTXHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:58:29 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)) 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:58:29 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-Ts2onQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:58:29 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)) 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:58:29 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-RWbC5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:58:29 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)) 23:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:58:29 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-6fCRgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:58:30 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)) 23:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:58:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-uTeysI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:58:30 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)) 23:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:58:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-sPb1Up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:58:30 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)) 23:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:58:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-oeLdkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:58:30 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)) 23:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:58:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-yA5ntT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:58:30 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)) 23:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:58:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-_rbTWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:58:30 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)) 23:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:58:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-Hmu7Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:58:30 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)) 23:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:58:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-OIbuJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:58:30 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)) 23:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:58:30 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-1PCXQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:58:31 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)) 23:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:58:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-RErokb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:58:31 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)) 23:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-NC5T4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:58:31 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)) 23:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:58:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-UBIZxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:58:31 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)) 23:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:58:31 INFO - Running setup.py (path:/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/pip-tpiyvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:58:31 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)) 23:58:31 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)) 23:58:31 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)) 23:58:31 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)) 23:58:31 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)) 23:58:31 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)) 23:58:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:58: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 23:58: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 23:58: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 23:58: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 23:58: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 23:58: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 23:58:33 INFO - Downloading blessings-1.5.1.tar.gz 23:58:33 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 23:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:58:34 INFO - Installing collected packages: blessings 23:58:34 INFO - Running setup.py install for blessings 23:58:34 INFO - Successfully installed blessings 23:58:34 INFO - Cleaning up... 23:58:34 INFO - Return code: 0 23:58:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:58:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:58:34 INFO - Reading from file tmpfile_stdout 23:58:34 INFO - Current package versions: 23:58:34 INFO - blessings == 1.5.1 23:58:34 INFO - blobuploader == 1.2.4 23:58:34 INFO - docopt == 0.6.1 23:58:34 INFO - manifestparser == 1.1 23:58:34 INFO - mozInstall == 1.12 23:58:34 INFO - mozcrash == 0.16 23:58:34 INFO - mozdebug == 0.1 23:58:34 INFO - mozdevice == 0.47 23:58:34 INFO - mozfile == 1.2 23:58:34 INFO - mozhttpd == 0.7 23:58:34 INFO - mozinfo == 0.9 23:58:34 INFO - mozleak == 0.1 23:58:34 INFO - mozlog == 3.0 23:58:34 INFO - moznetwork == 0.27 23:58:34 INFO - mozprocess == 0.22 23:58:34 INFO - mozprofile == 0.27 23:58:34 INFO - mozrunner == 6.11 23:58:34 INFO - mozscreenshot == 0.1 23:58:34 INFO - mozsystemmonitor == 0.0 23:58:34 INFO - moztest == 0.7 23:58:34 INFO - mozversion == 1.4 23:58:34 INFO - psutil == 3.1.1 23:58:34 INFO - requests == 1.2.3 23:58:34 INFO - wsgiref == 0.1.2 23:58:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:58: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')]} 23:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:58:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58: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')]} 23:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:58:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:58:34 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 0x10996c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109949228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f83dae3e0f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10988f9f0>, '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 0x1095efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098838c8>, '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.U3DaJEedFW/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.fiK7OD8D79/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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 23:58:34 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 23:58:34 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 23:58:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U3DaJEedFW/Render', 23:58:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:58:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:58:34 INFO - 'HOME': '/Users/cltbld', 23:58:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:58:34 INFO - 'LOGNAME': 'cltbld', 23:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:58:34 INFO - 'MOZ_NO_REMOTE': '1', 23:58:34 INFO - 'NO_EM_RESTART': '1', 23:58:34 INFO - 'PAGER': '/bin/cat', 23:58:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:58:34 INFO - 'PWD': '/builds/slave/test', 23:58:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:58:34 INFO - 'SHELL': '/bin/bash', 23:58:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fiK7OD8D79/Listeners', 23:58:34 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 23:58:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:58:34 INFO - 'USER': 'cltbld', 23:58:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:58:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:58:34 INFO - 'XPC_FLAGS': '0x0', 23:58:34 INFO - 'XPC_SERVICE_NAME': '0', 23:58:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:58:34 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)) 23:58:34 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)) 23:58:34 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)) 23:58:34 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)) 23:58:34 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)) 23:58:34 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)) 23:58:34 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)) 23:58:34 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)) 23:58:34 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)) 23:58:34 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)) 23:58:34 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)) 23:58:34 INFO - Cleaning up... 23:58:34 INFO - Return code: 0 23:58:34 INFO - Running post-action listener: _resource_record_post_action 23:58:34 INFO - Running post-action listener: _start_resource_monitoring 23:58:34 INFO - Starting resource monitoring. 23:58:34 INFO - ##### 23:58:34 INFO - ##### Running install step. 23:58:34 INFO - ##### 23:58:34 INFO - Running pre-action listener: _resource_record_pre_action 23:58:34 INFO - Running main action method: install 23:58:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:58:35 INFO - Reading from file tmpfile_stdout 23:58:35 INFO - Detecting whether we're running mozinstall >=1.0... 23:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:58:35 INFO - Reading from file tmpfile_stdout 23:58:35 INFO - Output received: 23:58:35 INFO - Usage: mozinstall [options] installer 23:58:35 INFO - Options: 23:58:35 INFO - -h, --help show this help message and exit 23:58:35 INFO - -d DEST, --destination=DEST 23:58:35 INFO - Directory to install application into. [default: 23:58:35 INFO - "/builds/slave/test"] 23:58:35 INFO - --app=APP Application being installed. [default: firefox] 23:58:35 INFO - mkdir: /builds/slave/test/build/application 23:58:35 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'] 23:58:35 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 23:59:13 INFO - Reading from file tmpfile_stdout 23:59:13 INFO - Output received: 23:59:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:59:13 INFO - Running post-action listener: _resource_record_post_action 23:59:13 INFO - ##### 23:59:13 INFO - ##### Running run-tests step. 23:59:13 INFO - ##### 23:59:13 INFO - Running pre-action listener: _resource_record_pre_action 23:59:13 INFO - Running main action method: run_tests 23:59:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:59:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:59:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:59:13 INFO - 2015-11-16 23:59:13.434 screenresolution[1937:12407] starting screenresolution argv=screenresolution get 23:59:13 INFO - 2015-11-16 23:59:13.437 screenresolution[1937:12407] Display 0: 1600x1200x32@60 23:59:13 INFO - 2015-11-16 23:59:13.443 screenresolution[1938:12409] starting screenresolution argv=screenresolution list 23:59:13 INFO - Available Modes on Display 0 23:59:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:59:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:59:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:59:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:59:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:59:13 INFO - Intel HD Graphics 3000: 23:59:13 INFO - Chipset Model: Intel HD Graphics 3000 23:59:13 INFO - Type: GPU 23:59:13 INFO - Bus: Built-In 23:59:13 INFO - VRAM (Total): 512 MB 23:59:13 INFO - VRAM (Dynamic, Max): 10 23:59:13 INFO - Vendor: Intel (0x8086) 23:59:13 INFO - Device ID: 0x0116 23:59:13 INFO - Revision ID: 0x0009 23:59:13 INFO - Displays: 23:59:13 INFO - Display: 23:59:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:59:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:59:13 INFO - Display Serial Number: 1600x1200 60 23:59:13 INFO - Main Display: Yes 23:59:13 INFO - Mirror: Off 23:59:13 INFO - Online: Yes 23:59:13 INFO - Rotation: Supported 23:59:13 INFO - Return code: 0 23:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:59:13 INFO - Python 2.7.3 23:59:13 INFO - Return code: 0 23:59:13 INFO - grabbing minidump binary from tooltool 23:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:59:13 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 0x10988f9f0>, '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 0x1095efdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1098838c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:59:13 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 23:59:13 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 23:59:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:59:13 INFO - Return code: 0 23:59:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:59:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:59:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:59:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:59:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:59:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0027', '--webServer', 'localhost'] in /builds/slave/test/build 23:59:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0027 --webServer localhost 23:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U3DaJEedFW/Render', 23:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:59:13 INFO - 'HOME': '/Users/cltbld', 23:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:59:13 INFO - 'LOGNAME': 'cltbld', 23:59:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:59:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:59:13 INFO - 'MOZ_NO_REMOTE': '1', 23:59:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:59:13 INFO - 'NO_EM_RESTART': '1', 23:59:13 INFO - 'PAGER': '/bin/cat', 23:59:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:59:13 INFO - 'PWD': '/builds/slave/test', 23:59:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:59:13 INFO - 'SHELL': '/bin/bash', 23:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fiK7OD8D79/Listeners', 23:59:13 INFO - 'TMPDIR': '/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/', 23:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:59:13 INFO - 'USER': 'cltbld', 23:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:59:13 INFO - 'XPC_FLAGS': '0x0', 23:59:13 INFO - 'XPC_SERVICE_NAME': '0', 23:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 23:59:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0027', '--webServer', 'localhost'] with output_timeout 3600 23:59:14 INFO - mozversion INFO | application_buildid: 20151116221703 23:59:14 INFO - mozversion INFO | application_changeset: 996fabe1edaa17ae416baf84089baa2c50076707 23:59:14 INFO - mozversion INFO | application_display_name: Nightly 23:59:14 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:59:14 INFO - mozversion INFO | application_name: Firefox 23:59:14 INFO - mozversion INFO | application_remotingname: firefox 23:59:14 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 23:59:14 INFO - mozversion INFO | application_vendor: Mozilla 23:59:14 INFO - mozversion INFO | application_version: 45.0a1 23:59:14 INFO - mozversion INFO | platform_buildid: 20151116221703 23:59:14 INFO - mozversion INFO | platform_changeset: 996fabe1edaa17ae416baf84089baa2c50076707 23:59:14 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 23:59:14 INFO - mozversion INFO | platform_version: 45.0a1 23:59:14 INFO - 2015-11-16 23:59:14,065 DEBUG : using testdate: 1447747154 23:59:14 INFO - 2015-11-16 23:59:14,065 DEBUG : actual date: 1447747154 23:59:14 INFO - 2015-11-16 23:59:14,074 INFO : starting webserver on 'localhost:49736' 23:59:14 INFO - 2015-11-16 23:59:14,075 INFO : Starting test suite t-yosemite-r5-0027 23:59:14 INFO - 2015-11-16 23:59:14,075 INFO : Starting test dromaeo_css 23:59:14 INFO - 2015-11-16 23:59:14,076 DEBUG : operating with platform_type : mac_ 23:59:14 INFO - 2015-11-16 23:59:14,076 INFO : Initialising browser for dromaeo_css test... 23:59:14 INFO - 2015-11-16 23:59:14,090 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmp_hcjoN/profile http://localhost:49736/getInfo.html 23:59:16 INFO - 2015-11-16 23:59:16,448 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:59:16 INFO - 2015-11-16 23:59:16,449 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:59:16 INFO - 2015-11-16 23:59:16,449 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 23:59:16 INFO - 2015-11-16 23:59:16,449 DEBUG : BROWSER_OUTPUT: __metrics 23:59:16 INFO - 2015-11-16 23:59:16,456 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:59:17 INFO - 2015-11-16 23:59:17,186 INFO : Browser initialized. 23:59:17 INFO - 2015-11-16 23:59:17,187 INFO : Running cycle 1/1 for dromaeo_css test... 23:59:17 INFO - 2015-11-16 23:59:17,187 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmp_hcjoN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:59:29 INFO - 2015-11-16 23:59:29,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 228462592 23:59:29 INFO - 2015-11-16 23:59:29,204 DEBUG : BROWSER_OUTPUT: 00:00:20 INFO - 2015-11-17 00:00:20,164 DEBUG : BROWSER_OUTPUT: 1447747220157 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] 00:02:31 INFO - 2015-11-17 00:02:31,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49736/tests/dromaeo/cssquery-ext.html) 00:02:32 INFO - 2015-11-17 00:02:32,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 374628352 00:02:32 INFO - 2015-11-17 00:02:32,595 DEBUG : BROWSER_OUTPUT: 00:05:35 INFO - 2015-11-17 00:05:35,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/dromaeo/cssquery-ext.html (next: http://localhost:49736/tests/dromaeo/cssquery-jquery.html) 00:05:35 INFO - 2015-11-17 00:05:35,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 380071936 00:05:35 INFO - 2015-11-17 00:05:35,938 DEBUG : BROWSER_OUTPUT: 00:08:38 INFO - 2015-11-17 00:08:38,087 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49736/tests/dromaeo/cssquery-mootools.html) 00:08:38 INFO - 2015-11-17 00:08:38,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 333979648 00:08:38 INFO - 2015-11-17 00:08:38,659 DEBUG : BROWSER_OUTPUT: 00:11:40 INFO - 2015-11-17 00:11:40,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49736/tests/dromaeo/cssquery-prototype.html) 00:11:41 INFO - 2015-11-17 00:11:41,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 327675904 00:11:41 INFO - 2015-11-17 00:11:41,371 DEBUG : BROWSER_OUTPUT: 00:14:44 INFO - 2015-11-17 00:14:44,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49736/tests/dromaeo/cssquery-yui.html) 00:14:45 INFO - 2015-11-17 00:14:45,181 DEBUG : BROWSER_OUTPUT: RSS: Main: 331358208 00:14:45 INFO - 2015-11-17 00:14:45,182 DEBUG : BROWSER_OUTPUT: 00:17:47 INFO - 2015-11-17 00:17:47,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/dromaeo/cssquery-yui.html (next: http://localhost:49736/tests/dromaeo/cssquery-dojo.html) 00:17:48 INFO - 2015-11-17 00:17:48,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 374341632 00:17:48 INFO - 2015-11-17 00:17:48,099 DEBUG : BROWSER_OUTPUT: 00:17:48 INFO - 2015-11-17 00:17:48,099 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:17:48 INFO - 2015-11-17 00:17:48,099 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:17:48 INFO - 2015-11-17 00:17:48,100 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:17:48 INFO - 2015-11-17 00:17:48,100 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:17:48 INFO - 2015-11-17 00:17:48,100 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3036.832974186419;3054.526548385;3093.4586447371703;3182.570353002344;3209.8555564999574;4936.456989731127;5046.167382381903;5062.012907483037;5064.949350506494;5078.085944529983;4962.801487940487;4986.875328116799;5001;5128.076946149691;5220.92168617471;4664;4674.532546745315;4688.906221875561;4689.601383882374;4779.378680771512;4734.053189362124;4746.715197088186;4754.191787396151;4777.80888764449;4803.663743537953;4458.77706114693;4542.159700455426;4594.494605593365;4608.23964045932;4716.669833111683;4532;4634.281686338623;4637.026224492861;4638.2115040443205;4665.533446655341;4667.089917466095;4674.462436819776;4681.227597446417;4720.079584481027;4745;4814.75926203692;5031.798728050873;5048;5049.267856160873;5051.040302342543;5395.78416863325;5396.325459317585;5417.8103766367985;5418.8916221675345;5420.403755586883;5363.302770639831;5430.185472179165;5438.972805135989;5458.863528411782;5462.6449280797015;5022.799088036474;5028.572571331441;5029.5724863386295;5032.194848824171;5036.748162591855;5509.47659972302;5510.448955104457;5512.0905050667;5515.4760297771645;5527.474889885454;5057.115004874132;5135.3324067870935;5175.094358487249;5269.683818970874;5299.920501192485;5432.185172224119;5468.56251499887;5474.534664553478;5486.231927530149;5493.066178749622;5370.570354371641;5375.838724838261;5384.488473595002;5393.83818485446;5412.539934105645;5072.416672082758;5240.6069544784295;5247.763850626731;5272.130098533699;5319.228711836762;4131.318332475168;4146.274401979642;4152.937705934413;4155.833766649361;4207.200631879933;3807.904802379963;3813.9427908581392;3829.885103446901;3838.3666694995013;3867.7099217558793;4995.725235112103;5005.424376196711;5120.257562653394;5125.410577783528;5142;5444.5916556258435;5445.673259604358;5452.154915988028;5495.120780675153;5556.611037227355;5110.488951104934;5111.897762044739;5128.9230661540105;5135.38375394955;5167.431582525919;4643.674942753974;4657.04530571232;4735.195016847144;4738.028704115648;4764.404449443819;5584.944150558443;5589.916151257816;5593.4126916674795;5636.210930469738;5638.915416268841;5454;5456.09974354243;5459.563234941115;5459.972700136474;5492.313460817398;5385.461453854583;5513.117901135799;5523.447655234444;5526.91709624364;5690.487856092972;5394.136938089887;5402.59480538969;5420.295361602966;5429.185622156708;5439;5432.619716619799;5458.781648734006;5459.672419654833;5501.697406642513;5522.530584900329;5097.949020509747;5209.7395130244095;5215.374155101412;5217.739113044408;5365.678059316453;5202.687838729688;5344.732763361739;5346.037713211659;5352.170413585744;5354.732263386893;5261.079311120615;5265.262863199232;5267.394249661338;5269.736513174403;5323.600729945192;5083.389993200692;5240.34495688039;5241.659292145999;5248.2390053442805;5373.247745315581;5169;5220.7650655721345;5224.164133738584;5266.605004624746;5274.920876186783 00:17:48 INFO - 2015-11-17 00:17:48,103 DEBUG : BROWSER_OUTPUT: |1;ext.html;531.8989392015517;533.7464704265475;540.7944980907255;554.8929884879665;564.9830505084849;29291;30134.54798178029;30134.94527691534;30146.24634384136;30159.69840301599;30824.229394265156;38093;38591.61408385915;38618.8069059655;38786;8535.87196192056;8627.180417860325;8631.65473381064;8646.697365592205;8647.351448641346;7841.882371764428;8025.478343907656;8472.576371181447;8533.317334613215;8563.272121869648;10370.740731481736;10513.684589462327;10551.050405463508;10558.52486638103;10579.629712960048;10138.543765530532;10247.795044099152;10288.485575721259;10298.227632927485;10316.123129533999;7703;7898.210178982114;10082.495875206283;10157.695269141937;10418.114460270886;36289.45565816515;36725.26549468996;36759;36903.63096369029;36909.26181476355;2679.423923856361;2751.6697996240378;2815.3806162644187;2904.0561817409425;3095.4428202923464;25385.111521096856;25689.48621027569;25721.614175787377;25943;26667;2270.4550907782013;2299.678045073691;2312.5259321838985;2326.7673232676766;2378.63131214662;242407;242497;242498;243876;245826;50958.49041509537;51289.743551282;51395.74302128465;51534.74232628813;51580.22629660558;47705.522944770106;48313;48315;48386.27420588694;56914.430855690916;15204.771928421083;16070.839291606935;16079.276432560562;16080.517584472485;16101.033937963759;11412.258203216765;11555.306681599131;11595.420228988516;11622.94188529052;11646.592369267035;17580.824191757918;17614.29542818273;17635.382761603283;17667.823321766875;17717.822821771617;8133.59332033396;8381.539015354092;8431.409801313972;8450.71830605733;8457.365697572706;882.6822343956171;909.8999110097884;961.1589858873485;1016.786474840277;1034.3483605328595;26214.86892565563;26604.14216516843;26822.329441763723;26885.462290754465;26944;1000.3197825478599;1014.9289549731448;1024.4826362686795;1052.5316234275674;1188.0733028237987;12483.438245278985;12725;12746.661600531996;12754.55359062447;12794.936025319814;226735;229916;230125;230141;233311;44528;44881.55118448839;44965.10069798586;44978;45279.54720452819;1294.087668193921;1306.0661626936785;1335.2188969452784;1336.659151916255;1338.0232430325916;24313.635295470227;25053.624195636716;25110;25120.12079577206;25155.119570814935;42177;42191.15617687568;42199.57800421956;42286;42346.78826605847;262941;269008;271122;301183;301832;29162.708372916;29443.85278073596;29548;29572.408551829274;29577;36262.63737362593;37097.25805483821;37446.812765935996;37682.8115859419;38058.0485487865;30642.693573064877;32216.355672885944;32334.676653233168;32584;32630.83684581562;31968.36063278675;31973.68026319707;31983.84008080038;32250.193745156557;32257.35485290328;31850.149573072627;32163.195920101247;32201.51697724583;32452.51321230136;32513;27553.448931020866;28339.574906376834;28772.42455150927;28987.42025159527;29380.853095734383;21412.166480268363;22087.889560552096;22434.887825560767;22476.77523224747;22504.212352568236 00:17:48 INFO - 2015-11-17 00:17:48,105 DEBUG : BROWSER_OUTPUT: |2;jquery.html;313.09047217832205;314.44029627263467;319.426629200585;320.0797706593544;325.8452235188285;13646.795298070538;14084.929575352135;16413.097279649628;16490.58773530661;17007.06461144638;10895.945520272408;11203.831942520868;11238.100951923847;12909.160904541199;16600.58498537537;4112.506499220083;4113.239050775609;4204;4210.894727631803;4244.830206791725;4130.586941305861;4141.5237247716595;4175.248455278049;4189.518205406387;4194.66442684586;4128.607782260696;4131.21506913687;4138;4153.0863210093885;4174.603412675791;4072.429859819613;4154.376843473503;4156.91686166278;4158.08522125132;4166.020985068521;3554.7689400189165;3558.6619271169197;3563.6970857476886;3565.554305711786;3584.5877724061806;12233.632991010283;12429.751404971941;12469.376531173404;12470.127091103626;12589.748205035849;1687.856532194765;1734.0809371033372;1739.1304347826087;1788.5975655477544;1805.3861687026342;8824.911750882473;9084.40951338161;9132.08679132088;9149.634014639407;9229.353945223836;1423.3310344138238;1443.7329094117517;1456.3810380588313;1472.830624478188;1521.8325984141736;48767.756161219324;49854.50145498535;50114.749426253;50433.24350134751;55376.16935746007;6129.662868542184;6131.14164017038;6131.570790044654;6172.105044768484;6204.317525072239;6623.503237257225;6656.83357916056;6752;6987.1266091738535;6991.161060672752;5000.024995125988;5012.949870501248;5024.522670346311;5084.669496482717;5153.665011774223;5337.786488540415;5623.578231632644;5685.744141513642;5689.061304884731;5689.630174038674;2738.87675054623;2764.226016715323;2767.0868613357543;2778;2784.6240757497885;965.034965034965;966.8743063401713;974.055166488505;974.0940924939732;1023.9078482936422;380.1579501404403;414.7366422321787;424.92563801334643;430.56082795548366;432.86364795089446;10828.675139745821;11277.94361028206;11289.830652540219;11333.376664283544;11477.885221147848;415.5283752940434;418.19914863037553;431.35297054418373;433.78527628823934;442.7476338487032;4853.563179313879;5885.499732522783;6081.3614570470345;6127.662978536134;6227.159333489921;476112;476288;477034;479879;486196;62676.373236267966;62996.37003629905;63646.36353636497;64036.35963640397;66650.33349666538;428.2676622974748;434.4374035623812;439.0275539679561;443.3792690233699;457.4967535710692;10148.594056237964;10252.487375631039;10370.377777333082;10402.687919362432;10431;31818.68181318157;32900.67099328976;32923;32998.67001330052;33537.83231083829;43145.784271078446;43302.56697432986;43559;43919.56080439155;44274.55725442704;5624.521915637217;5853.736581853912;5878;5890.793822216202;5900.43945825146;10775.838362424412;11062.668119956414;11084.501197445972;11176.776464470502;11193.944030279796;9157.679481218125;9544.284178686488;9565.234781217347;9674.274429417681;9680.612775488902;9004.954975225082;9247.306452015991;9260.814783704423;9303.395279306824;9319.114684105;9696.17582505495;9742.366746161477;9745.951270243604;9826.115649591571;9843.458609776531;5698.4016678249845;5833.7666493341485;5840.2115714378015;5844.736986835517;5845.269341332333;9262.027487114026;9269.212116970133;9295.86056209171;9328.300377471853;9609.039096090335 00:17:48 INFO - 2015-11-17 00:17:48,108 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1438.5109062918618;1627.210802760661;1693.1449617942937;1706.5221737913384;1727.3695101288033;6802.353776391247;7227.4218062555;7259.419246460284;7405.407567394609;7415.888761668572;7037.472189585776;7094.148702155749;7132.643367831613;7135.785926422215;7152;2080.4382816639572;2092.905819238138;2107.0097054384414;2112.2818241797786;2117.2589593642256;2104.5264815416563;2125.1605615781755;2126.5215326551556;2141.625215587266;2145.839062070343;1837.4212123181155;1899.886006839594;1976.8023197680188;2051;2066.380085974202;2071.0680193912726;2088.749350077985;2099.9685004724943;2100.5063810004635;2108.7258656374725;2122.3420739570784;2147.9463013424634;2150.4408853697996;2153.321703663357;2165.361218440564;7472.028636277303;7553.131389890178;7571.659275332623;7574.886376704354;7583.582902940336;4537.115262523809;4624.028953919681;4634.83778067766;4640.303954406832;4683.297505374221;2650.2844232057428;2763.5301998660075;2767.3635063935208;2769.252301878502;2777.9444411111867;814.0028465130168;829.4484168028254;852.8081181734123;854.2909385210261;854.5470900422786;10230.283880128394;10239.232057595711;10240.846387304122;10242.334248273839;10268.640597579124;3915.334393153171;4090.8159132839096;4095.6313931746286;4103.876883693494;4119.855805046809;7987.800304992422;8226.917730822615;8366.623501942428;8381.580920953927;8382.245597896097;4351.08627188294;4371.584699453547;4382.561743825592;4405.66957478184;4410.867673969786;3927.5483319418063;3930.9803450982563;3931.744436611611;3936.7834769087403;3953.4069889516227;3389.881354152642;3398.5581874356176;3422.7261819054415;3444.7071998880374;3453.430184019659;1107.1087774341731;1112.3993043756443;1117.603250845938;1125.6060378867494;1129.6215767717742;911.1799380557551;934.5747684803398;935.1396715022059;965.6475386484024;1256.9497220111275;7162.140543134858;7169.749058782918;7196.0285361475535;7210.89183662235;7227.27727227273;617.4905702795212;618.038949433626;623.7692053940071;630.1430055125027;632.7975047984601;5555.833325000256;5578.163275508625;5603.10350343943;5614.157876318503;5644;8313.33493320533;8386.580670966427;8488.320934325238;8570.614322355508;8577.742667719978;8411.200935911078;8448.028476725132;8488;8514.106018868053;8527.530985795716;6701.932980670228;6754.898676519856;6767.593944363354;6805.557638753465;6814.114165158498;6578.80263592093;6580.605163690194;6582.967085164543;6586.045023471665;6604.240512341143;7417.295356941082;7536.849263014599;7541.396688264816;7616.3906887447765;7688.077430708351;7690.126975127181;7726.381889448943;7732.729354472566;7818.960905195438;7929.048514178336;5870.853228669147;6054.848628784315;6256.405641464054;6281.497480201664;6361.268454127835;6977.232504424408;7192.172900116344;7245.673944672608;7254.637268136466;7273.0181425509;6672;6749.5612785168805;6772;6838.213605435439;6930.688119034555;6660.933390666031;6666.7996171027135;6713.429358504386;6727.663616819237;6747.831304217434;6712.563683360566;6762.7294908205085;6818.113645226089;6819.795406137824;6844.041834143124;6132;6167.444929956326;6173.104899789416;6174.135621012972;6182.938170618237;6253.218347706536;6298.653574053471;6299.181106456314;6300.086487459384;6315.115883776183 00:17:48 INFO - 2015-11-17 00:17:48,109 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.36134130947806;301.7314590014887;301.78422427964;302.8818760683333;303.4886216724819;5739.827805165852;5850.2394688690465;5880.26496687914;5898.88202235955;5898.88202235955;5762.078067509199;5836.854078648036;5869.295684517853;5897.144913987469;5910.202122713433;4476.283794592866;4494.97752511237;4497.168023915569;4502.324651302298;4522.118186953546;4327.0047888985555;4394.209042372372;4509.751963641998;4519.4124763780665;4528.932066018996;4166.333386658135;4376.868693939187;4398.86803395897;4431.468223813147;4480.372747815292;4433.822647094113;4434.512203657595;4448.599626033656;4452.68831181819;4457.509673935864;3817.026658202141;3831.1954489557224;3831.597682243352;3832.118612719062;3856.9228615427814;5538.529225015878;5737.598368114233;5741;5745.942540574624;5773.393793651648;5061.190209566452;5063.139266324733;5080.847574572768;5082.822101226477;5084.822031228926;6192.071189321593;6193.87612247757;6198;6205.658688772116;6228.844278893064;3991.8004099794894;4088.34586466164;4090.611391917763;4096.754194748325;4173.39485774564;6525.608463492158;6528.51036172289;6536.150300460958;6550.181227346582;6559.508036897252;4255.425517555091;4267.125239325931;4274.252005898955;4280.700350975402;4290.29210180323;4323.913521729548;4333.631641310524;4338.717983331074;4342;4348.67384946124;4873.634477414208;5050.3182070420025;5065.240213967934;5070.188769796815;5085.821996230115;6191.4118158774845;6199.039148931923;6202.875942481125;6224.066390041439;6226.688665566703;1513.1677577332423;1536.6093685214898;1538.6538028943621;1539.2150003498073;1544.3050627217797;983.9950800245953;1003.7590978165188;1013.852991316255;1014.1531820929459;1032.5456799008412;5969.522438204933;5969.522438204933;5984.790532331347;5986.521078313812;5989.251343582052;6437.710303036374;6446.580972236789;6448.161738973997;6461.256955450183;6509.316521765241;5980.581359304807;5987.341392446828;5990.400959903975;5997.640141591519;6011.008183649737;3399.167204035027;3498;3513.648635136517;3515.068506845688;3518.1556426457464;6717.328267173243;6718.395344419026;6721.092652491949;6724.831879203059;6759.459243260528;6680.298568650222;6685.130932978682;6695.163104611924;6703.564268322543;6712.194536655535;6459.321771214049;6691.330866913269;6694.09629699994;6704.161979752531;6708.597484150967;6506.479481641552;6510.7721229756735;6513.804585862432;6519.771807986698;6524.543281970216;6104.6642434664745;6306.999999999816;6308.558400911892;6317.7157027932935;6390.936090639034;6571.704273307808;6582.144321238208;6709.899351509829;6715.26132125456;6736.7642132525125;4112.794360281914;4199.790010499524;4202.096549241927;4202.2646036944025;4244.2996905510245;6251.937480625135;6446.09754634361;6460.192475940507;6492.935070649422;6498.707558159799;6305.1172835803945;6312.242530896322;6325.588836725598;6326.525510586633;6338.461230795434;6259.499240060875;6276.529260305587;6279.372062793684;6280.434760871543;6287.2140982377205;5983;6166.136740856194;6178.567500275118;6212.285587157354;6212.689365531795;6309.779157729457;6322.114903913548;6325.430711236011;6343.904841427475;6345.777897773741;6186.907196392148;6254.9687251563455;6255.030470277115;6259.593126446766;6259.718312676032 00:17:48 INFO - 2015-11-17 00:17:48,112 DEBUG : BROWSER_OUTPUT: |5;yui.html;618.7092066728636;681.9011243369712;694.871448781975;699.0841996983949;709.0427922304889;10410.791784164312;10794.622188223413;11014.944925275382;11131.833022504668;11160.999999999989;11115.944420277887;11175.497102630381;11203.887961120387;11207.887921120786;11247.943760281207;641.9632293845452;646.9450096741782;794.6980147543925;811.1037303779298;811.9553424561647;663.6980174020833;796.7012370361115;814.5519964019795;820.6061090676479;821.1829229916242;824.3446460064233;845.1970627903486;845.3364109174299;846.3609974469267;846.7925358287198;671.2012704881224;682.7132604306204;819.6762278899802;837.1921096142222;838.0906716212917;610.8289678889873;616.6454288783967;617.2623714660982;617.6139912554653;617.728199592178;9999;10114;10126.088652021353;10134.442605656686;10157.339772914736;8871.512066836322;9073.773155671095;9109.134632209929;9294.488803115826;9522;8271.13153118926;8368.874466883002;8387.916120838774;8472.957635211846;8933.15135062168;2584.5477041517847;2632.9868350658317;2742.149933520615;2765.391613844951;2768.4463107378606;43767.56232437699;44361.334579981005;44466.555334446886;44756.3286550702;44907.550924490664;6118.082287656887;6265.62406255617;6406.071119687619;6514.218293804774;6600.075989361493;11049;11118;11163.553457861595;11203.383813890152;11235.494402751896;5368.597355198376;5376.677399355973;5386.703731294817;5487.396386397493;5520.089185284383;3366.5286859839152;3418.384690755638;3463.0264837268505;3483.965160348415;3656.634336566322;2493.426511902236;2511.259178542334;2513.9120130795336;2516.8993240270183;2518.1690042286;370.5423801605016;371.68406854173736;372.5510759534754;373.77947011263484;377.3905143193777;465.9277811939155;520.7396301849076;534.8636097795037;584.1243350370323;589.669784920446;6889.276625954303;7041.295870413021;7359.411247100219;7483;7505.061867266591;530.9256704061435;530.9480294993143;562.4291344285554;564.2326436046973;575.1832397994857;3212.550242965987;3267.575215222006;3288.342331533655;3288.8848890288723;3334.899953001414;55916.44083559194;58616.413835861946;58634.12048819271;59565.40434595685;59578.70210648919;46703;46794.298085528746;47486;48712;49356.75321623441;43154.13691726148;43249.783751081675;43473.565264347584;45252.54747452549;45751.08497830091;7740.806479838049;7890.210978902293;7992.200779921961;8061.072976607531;8215.507069575844;32123.357532848746;32882.20501257324;32938;33141;33596.160095997795;42578.78710606427;44339.55660443483;44377.33433998557;44522.77738611286;44832.551674482835;6815.284395138439;6942.930570694229;7032.613206273704;7112.644367781693;7125.964370178116;10109.797804044025;10695.625653102104;10863.891361086287;11042.889571104508;11461.140414469115;9925.602975880884;10035.498225088862;10302.22733294991;10378.948105259426;10734.67795966091;9840.901590984286;9886.406815591088;10239.129673977795;10342.069213770797;10622.20333474977;6063.423974722395;9137.862932056158;9825.95087024589;10145.594176233164;10189.133923616575;8457.61940712657;8522.105178956368;8743.519106448952;8837.955810220908;8901.376903616685;8380.287675547646;8562.785930351542;8578.871316930376;8723.65105395777;8909.465432074096 00:17:48 INFO - 2015-11-17 00:17:48,112 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:17:48 INFO - 2015-11-17 00:17:48,112 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:17:48 INFO - 2015-11-17 00:17:48,112 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1186 00:17:48 INFO - 2015-11-17 00:17:48,113 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:17:48 INFO - 2015-11-17 00:17:48,113 DEBUG : BROWSER_OUTPUT: __startTimestamp1447748268097__endTimestamp 00:17:48 INFO - 2015-11-17 00:17:48,113 DEBUG : BROWSER_OUTPUT: 00:17:48 INFO - 2015-11-17 00:17:48,113 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:17:48 INFO - 2015-11-17 00:17:48,113 DEBUG : BROWSER_OUTPUT: Number of tests: 6 00:17:48 INFO - 2015-11-17 00:17:48,113 DEBUG : BROWSER_OUTPUT: 00:17:48 INFO - 2015-11-17 00:17:48,113 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5042.58 Median:5209.74 stddev:530.81 (10.2%) stddev-sans-first:508.58 00:17:48 INFO - 2015-11-17 00:17:48,114 DEBUG : BROWSER_OUTPUT: Values: 3036.8 3054.5 3093.5 3182.6 3209.9 4936.5 5046.2 5062.0 5064.9 5078.1 4962.8 4986.9 5001.0 5128.1 5220.9 4664.0 4674.5 4688.9 4689.6 4779.4 4734.1 4746.7 4754.2 4777.8 4803.7 4458.8 4542.2 4594.5 4608.2 4716.7 4532.0 4634.3 4637.0 4638.2 4665.5 4667.1 4674.5 4681.2 4720.1 4745.0 4814.8 5031.8 5048.0 5049.3 5051.0 5395.8 5396.3 5417.8 5418.9 5420.4 5363.3 5430.2 5439.0 5458.9 5462.6 5022.8 5028.6 5029.6 5032.2 5036.7 5509.5 5510.4 5512.1 5515.5 5527.5 5057.1 5135.3 5175.1 5269.7 5299.9 5432.2 5468.6 5474.5 5486.2 5493.1 5370.6 5375.8 5384.5 5393.8 5412.5 5072.4 5240.6 5247.8 5272.1 5319.2 4131.3 4146.3 4152.9 4155.8 4207.2 3807.9 3813.9 3829.9 3838.4 3867.7 4995.7 5005.4 5120.3 5125.4 5142.0 5444.6 5445.7 5452.2 5495.1 5556.6 5110.5 5111.9 5128.9 5135.4 5167.4 4643.7 4657.0 4735.2 4738.0 4764.4 5584.9 5589.9 5593.4 5636.2 5638.9 5454.0 5456.1 5459.6 5460.0 5492.3 5385.5 5513.1 5523.4 5526.9 5690.5 5394.1 5402.6 5420.3 5429.2 5439.0 5432.6 5458.8 5459.7 5501.7 5522.5 5097.9 5209.7 5215.4 5217.7 5365.7 5202.7 5344.7 5346.0 5352.2 5354.7 5261.1 5265.3 5267.4 5269.7 5323.6 5083.4 5240.3 5241.7 5248.2 5373.2 5169.0 5220.8 5224.2 5266.6 5274.9 00:17:48 INFO - 2015-11-17 00:17:48,114 DEBUG : BROWSER_OUTPUT: 00:17:48 INFO - 2015-11-17 00:17:48,114 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40568.40 Median:16033.38 stddev:65785.74 (410.3%) stddev-sans-first:65901.61 00:17:48 INFO - 2015-11-17 00:17:48,115 DEBUG : BROWSER_OUTPUT: Values: 531.9 533.7 540.8 554.9 565.0 29291.0 30134.5 30134.9 30146.2 30159.7 30824.2 38093.0 38591.6 38618.8 38786.0 8535.9 8627.2 8631.7 8646.7 8647.4 7841.9 8025.5 8472.6 8533.3 8563.3 10370.7 10513.7 10551.1 10558.5 10579.6 10138.5 10247.8 10288.5 10298.2 10316.1 7703.0 7898.2 10082.5 10157.7 10418.1 36289.5 36725.3 36759.0 36903.6 36909.3 2679.4 2751.7 2815.4 2904.1 3095.4 25385.1 25689.5 25721.6 25943.0 26667.0 2270.5 2299.7 2312.5 2326.8 2378.6 242407.0 242497.0 242498.0 243876.0 245826.0 50958.5 51289.7 51395.7 51534.7 51580.2 47705.5 48313.0 48315.0 48386.3 56914.4 15204.8 16070.8 16079.3 16080.5 16101.0 11412.3 11555.3 11595.4 11622.9 11646.6 17580.8 17614.3 17635.4 17667.8 17717.8 8133.6 8381.5 8431.4 8450.7 8457.4 882.7 909.9 961.2 1016.8 1034.3 26214.9 26604.1 26822.3 26885.5 26944.0 1000.3 1014.9 1024.5 1052.5 1188.1 12483.4 12725.0 12746.7 12754.6 12794.9 226735.0 229916.0 230125.0 230141.0 233311.0 44528.0 44881.6 44965.1 44978.0 45279.5 1294.1 1306.1 1335.2 1336.7 1338.0 24313.6 25053.6 25110.0 25120.1 25155.1 42177.0 42191.2 42199.6 42286.0 42346.8 262941.0 269008.0 271122.0 301183.0 301832.0 29162.7 29443.9 29548.0 29572.4 29577.0 36262.6 37097.3 37446.8 37682.8 38058.0 30642.7 32216.4 32334.7 32584.0 32630.8 31968.4 31973.7 31983.8 32250.2 32257.4 31850.1 32163.2 32201.5 32452.5 32513.0 27553.4 28339.6 28772.4 28987.4 29380.9 21412.2 22087.9 22434.9 22476.8 22504.2 00:17:48 INFO - 2015-11-17 00:17:48,115 DEBUG : BROWSER_OUTPUT: 00:17:48 INFO - 2015-11-17 00:17:48,116 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23901.68 Median:433.32 stddev:78456.02 (18105.6%) stddev-sans-first:78656.11 00:17:48 INFO - 2015-11-17 00:17:48,117 DEBUG : BROWSER_OUTPUT: Values: 313.1 314.4 319.4 320.1 325.8 13646.8 14084.9 16413.1 16490.6 17007.1 10895.9 11203.8 11238.1 12909.2 16600.6 4112.5 4113.2 4204.0 4210.9 4244.8 4130.6 4141.5 4175.2 4189.5 4194.7 4128.6 4131.2 4138.0 4153.1 4174.6 4072.4 4154.4 4156.9 4158.1 4166.0 3554.8 3558.7 3563.7 3565.6 3584.6 12233.6 12429.8 12469.4 12470.1 12589.7 1687.9 1734.1 1739.1 1788.6 1805.4 8824.9 9084.4 9132.1 9149.6 9229.4 1423.3 1443.7 1456.4 1472.8 1521.8 48767.8 49854.5 50114.7 50433.2 55376.2 6129.7 6131.1 6131.6 6172.1 6204.3 6623.5 6656.8 6752.0 6987.1 6991.2 5000.0 5012.9 5024.5 5084.7 5153.7 5337.8 5623.6 5685.7 5689.1 5689.6 2738.9 2764.2 2767.1 2778.0 2784.6 965.0 966.9 974.1 974.1 1023.9 380.2 414.7 424.9 430.6 432.9 10828.7 11277.9 11289.8 11333.4 11477.9 415.5 418.2 431.4 433.8 442.7 4853.6 5885.5 6081.4 6127.7 6227.2 476112.0 476288.0 477034.0 479879.0 486196.0 62676.4 62996.4 63646.4 64036.4 66650.3 428.3 434.4 439.0 443.4 457.5 10148.6 10252.5 10370.4 10402.7 10431.0 31818.7 32900.7 32923.0 32998.7 33537.8 43145.8 43302.6 43559.0 43919.6 44274.6 5624.5 5853.7 5878.0 5890.8 5900.4 10775.8 11062.7 11084.5 11176.8 11193.9 9157.7 9544.3 9565.2 9674.3 9680.6 9005.0 9247.3 9260.8 9303.4 9319.1 9696.2 9742.4 9746.0 9826.1 9843.5 5698.4 5833.8 5840.2 5844.7 5845.3 9262.0 9269.2 9295.9 9328.3 9609.0 00:17:48 INFO - 2015-11-17 00:17:48,117 DEBUG : BROWSER_OUTPUT: 00:17:48 INFO - 2015-11-17 00:17:48,117 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5104.66 Median:3464.66 stddev:2658.11 (76.7%) stddev-sans-first:2651.29 00:17:48 INFO - 2015-11-17 00:17:48,119 DEBUG : BROWSER_OUTPUT: Values: 1438.5 1627.2 1693.1 1706.5 1727.4 6802.4 7227.4 7259.4 7405.4 7415.9 7037.5 7094.1 7132.6 7135.8 7152.0 2080.4 2092.9 2107.0 2112.3 2117.3 2104.5 2125.2 2126.5 2141.6 2145.8 1837.4 1899.9 1976.8 2051.0 2066.4 2071.1 2088.7 2100.0 2100.5 2108.7 2122.3 2147.9 2150.4 2153.3 2165.4 7472.0 7553.1 7571.7 7574.9 7583.6 4537.1 4624.0 4634.8 4640.3 4683.3 2650.3 2763.5 2767.4 2769.3 2777.9 814.0 829.4 852.8 854.3 854.5 10230.3 10239.2 10240.8 10242.3 10268.6 3915.3 4090.8 4095.6 4103.9 4119.9 7987.8 8226.9 8366.6 8381.6 8382.2 4351.1 4371.6 4382.6 4405.7 4410.9 3927.5 3931.0 3931.7 3936.8 3953.4 3389.9 3398.6 3422.7 3444.7 3453.4 1107.1 1112.4 1117.6 1125.6 1129.6 911.2 934.6 935.1 965.6 1256.9 7162.1 7169.7 7196.0 7210.9 7227.3 617.5 618.0 623.8 630.1 632.8 5555.8 5578.2 5603.1 5614.2 5644.0 8313.3 8386.6 8488.3 8570.6 8577.7 8411.2 8448.0 8488.0 8514.1 8527.5 6701.9 6754.9 6767.6 6805.6 6814.1 6578.8 6580.6 6583.0 6586.0 6604.2 7417.3 7536.8 7541.4 7616.4 7688.1 7690.1 7726.4 7732.7 7819.0 7929.0 5870.9 6054.8 6256.4 6281.5 6361.3 6977.2 7192.2 7245.7 7254.6 7273.0 6672.0 6749.6 6772.0 6838.2 6930.7 6660.9 6666.8 6713.4 6727.7 6747.8 6712.6 6762.7 6818.1 6819.8 6844.0 6132.0 6167.4 6173.1 6174.1 6182.9 6253.2 6298.7 6299.2 6300.1 6315.1 00:17:48 INFO - 2015-11-17 00:17:48,119 DEBUG : BROWSER_OUTPUT: 00:17:48 INFO - 2015-11-17 00:17:48,119 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5195.18 Median:5975.05 stddev:1609.71 (26.9%) stddev-sans-first:1571.67 00:17:48 INFO - 2015-11-17 00:17:48,120 DEBUG : BROWSER_OUTPUT: Values: 296.4 301.7 301.8 302.9 303.5 5739.8 5850.2 5880.3 5898.9 5898.9 5762.1 5836.9 5869.3 5897.1 5910.2 4476.3 4495.0 4497.2 4502.3 4522.1 4327.0 4394.2 4509.8 4519.4 4528.9 4166.3 4376.9 4398.9 4431.5 4480.4 4433.8 4434.5 4448.6 4452.7 4457.5 3817.0 3831.2 3831.6 3832.1 3856.9 5538.5 5737.6 5741.0 5745.9 5773.4 5061.2 5063.1 5080.8 5082.8 5084.8 6192.1 6193.9 6198.0 6205.7 6228.8 3991.8 4088.3 4090.6 4096.8 4173.4 6525.6 6528.5 6536.2 6550.2 6559.5 4255.4 4267.1 4274.3 4280.7 4290.3 4323.9 4333.6 4338.7 4342.0 4348.7 4873.6 5050.3 5065.2 5070.2 5085.8 6191.4 6199.0 6202.9 6224.1 6226.7 1513.2 1536.6 1538.7 1539.2 1544.3 984.0 1003.8 1013.9 1014.2 1032.5 5969.5 5969.5 5984.8 5986.5 5989.3 6437.7 6446.6 6448.2 6461.3 6509.3 5980.6 5987.3 5990.4 5997.6 6011.0 3399.2 3498.0 3513.6 3515.1 3518.2 6717.3 6718.4 6721.1 6724.8 6759.5 6680.3 6685.1 6695.2 6703.6 6712.2 6459.3 6691.3 6694.1 6704.2 6708.6 6506.5 6510.8 6513.8 6519.8 6524.5 6104.7 6307.0 6308.6 6317.7 6390.9 6571.7 6582.1 6709.9 6715.3 6736.8 4112.8 4199.8 4202.1 4202.3 4244.3 6251.9 6446.1 6460.2 6492.9 6498.7 6305.1 6312.2 6325.6 6326.5 6338.5 6259.5 6276.5 6279.4 6280.4 6287.2 5983.0 6166.1 6178.6 6212.3 6212.7 6309.8 6322.1 6325.4 6343.9 6345.8 6186.9 6255.0 6255.0 6259.6 6259.7 00:17:48 INFO - 2015-11-17 00:17:48,120 DEBUG : BROWSER_OUTPUT: 00:17:48 INFO - 2015-11-17 00:17:48,120 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12294.07 Median:5437.05 stddev:15582.31 (286.6%) stddev-sans-first:15601.36 00:17:48 INFO - 2015-11-17 00:17:48,122 DEBUG : BROWSER_OUTPUT: Values: 618.7 681.9 694.9 699.1 709.0 10410.8 10794.6 11014.9 11131.8 11161.0 11115.9 11175.5 11203.9 11207.9 11247.9 642.0 646.9 794.7 811.1 812.0 663.7 796.7 814.6 820.6 821.2 824.3 845.2 845.3 846.4 846.8 671.2 682.7 819.7 837.2 838.1 610.8 616.6 617.3 617.6 617.7 9999.0 10114.0 10126.1 10134.4 10157.3 8871.5 9073.8 9109.1 9294.5 9522.0 8271.1 8368.9 8387.9 8473.0 8933.2 2584.5 2633.0 2742.1 2765.4 2768.4 43767.6 44361.3 44466.6 44756.3 44907.6 6118.1 6265.6 6406.1 6514.2 6600.1 11049.0 11118.0 11163.6 11203.4 11235.5 5368.6 5376.7 5386.7 5487.4 5520.1 3366.5 3418.4 3463.0 3484.0 3656.6 2493.4 2511.3 2513.9 2516.9 2518.2 370.5 371.7 372.6 373.8 377.4 465.9 520.7 534.9 584.1 589.7 6889.3 7041.3 7359.4 7483.0 7505.1 530.9 530.9 562.4 564.2 575.2 3212.6 3267.6 3288.3 3288.9 3334.9 55916.4 58616.4 58634.1 59565.4 59578.7 46703.0 46794.3 47486.0 48712.0 49356.8 43154.1 43249.8 43473.6 45252.5 45751.1 7740.8 7890.2 7992.2 8061.1 8215.5 32123.4 32882.2 32938.0 33141.0 33596.2 42578.8 44339.6 44377.3 44522.8 44832.6 6815.3 6942.9 7032.6 7112.6 7126.0 10109.8 10695.6 10863.9 11042.9 11461.1 9925.6 10035.5 10302.2 10378.9 10734.7 9840.9 9886.4 10239.1 10342.1 10622.2 6063.4 9137.9 9826.0 10145.6 10189.1 8457.6 8522.1 8743.5 8838.0 8901.4 8380.3 8562.8 8578.9 8723.7 8909.5 00:17:48 INFO - 2015-11-17 00:17:48,122 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:17:48 INFO - 2015-11-17 00:17:48,122 DEBUG : BROWSER_OUTPUT: 00:17:48 INFO - 2015-11-17 00:17:48,558 INFO : Browser exited with error code: 0 00:17:48 INFO - 2015-11-17 00:17:48,587 INFO : Completed test dromaeo_css (00:18:34) 00:17:48 INFO - 2015-11-17 00:17:48,588 INFO : Starting test kraken 00:17:48 INFO - 2015-11-17 00:17:48,588 DEBUG : operating with platform_type : mac_ 00:17:48 INFO - 2015-11-17 00:17:48,588 INFO : Initialising browser for kraken test... 00:17:48 INFO - 2015-11-17 00:17:48,601 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpC0LTRZ/profile http://localhost:49736/getInfo.html 00:17:50 INFO - 2015-11-17 00:17:50,911 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:17:50 INFO - 2015-11-17 00:17:50,911 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:17:50 INFO - 2015-11-17 00:17:50,911 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 00:17:50 INFO - 2015-11-17 00:17:50,911 DEBUG : BROWSER_OUTPUT: __metrics 00:17:50 INFO - 2015-11-17 00:17:50,920 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:17:51 INFO - 2015-11-17 00:17:51,618 INFO : Browser initialized. 00:17:51 INFO - 2015-11-17 00:17:51,619 INFO : Running cycle 1/1 for kraken test... 00:17:51 INFO - 2015-11-17 00:17:51,619 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpC0LTRZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:18:03 INFO - 2015-11-17 00:18:03,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 229343232 00:18:03 INFO - 2015-11-17 00:18:03,628 DEBUG : BROWSER_OUTPUT: 00:18:06 INFO - 2015-11-17 00:18:06,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49736/tests/kraken/driver.html?testName=audio-beat-detection) 00:18:06 INFO - 2015-11-17 00:18:06,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 285290496 00:18:06 INFO - 2015-11-17 00:18:06,736 DEBUG : BROWSER_OUTPUT: 00:18:09 INFO - 2015-11-17 00:18:09,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49736/tests/kraken/driver.html?testName=audio-dft) 00:18:09 INFO - 2015-11-17 00:18:09,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 297943040 00:18:09 INFO - 2015-11-17 00:18:09,967 DEBUG : BROWSER_OUTPUT: 00:18:12 INFO - 2015-11-17 00:18:12,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49736/tests/kraken/driver.html?testName=audio-fft) 00:18:13 INFO - 2015-11-17 00:18:13,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 281157632 00:18:13 INFO - 2015-11-17 00:18:13,520 DEBUG : BROWSER_OUTPUT: 00:18:15 INFO - 2015-11-17 00:18:15,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49736/tests/kraken/driver.html?testName=audio-oscillator) 00:18:16 INFO - 2015-11-17 00:18:16,153 DEBUG : BROWSER_OUTPUT: RSS: Main: 282337280 00:18:16 INFO - 2015-11-17 00:18:16,153 DEBUG : BROWSER_OUTPUT: 00:18:18 INFO - 2015-11-17 00:18:18,374 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49736/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:18:18 INFO - 2015-11-17 00:18:18,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 283901952 00:18:18 INFO - 2015-11-17 00:18:18,951 DEBUG : BROWSER_OUTPUT: 00:18:22 INFO - 2015-11-17 00:18:22,097 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49736/tests/kraken/driver.html?testName=imaging-darkroom) 00:18:22 INFO - 2015-11-17 00:18:22,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 282689536 00:18:22 INFO - 2015-11-17 00:18:22,680 DEBUG : BROWSER_OUTPUT: 00:18:25 INFO - 2015-11-17 00:18:25,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49736/tests/kraken/driver.html?testName=imaging-desaturate) 00:18:26 INFO - 2015-11-17 00:18:26,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 285257728 00:18:26 INFO - 2015-11-17 00:18:26,545 DEBUG : BROWSER_OUTPUT: 00:18:29 INFO - 2015-11-17 00:18:29,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49736/tests/kraken/driver.html?testName=json-parse-financial) 00:18:30 INFO - 2015-11-17 00:18:30,074 DEBUG : BROWSER_OUTPUT: RSS: Main: 283545600 00:18:30 INFO - 2015-11-17 00:18:30,074 DEBUG : BROWSER_OUTPUT: 00:18:31 INFO - 2015-11-17 00:18:31,653 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49736/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:18:32 INFO - 2015-11-17 00:18:32,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 319283200 00:18:32 INFO - 2015-11-17 00:18:32,224 DEBUG : BROWSER_OUTPUT: 00:18:34 INFO - 2015-11-17 00:18:34,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49736/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:18:34 INFO - 2015-11-17 00:18:34,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 320765952 00:18:34 INFO - 2015-11-17 00:18:34,701 DEBUG : BROWSER_OUTPUT: 00:18:36 INFO - 2015-11-17 00:18:36,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49736/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:18:37 INFO - 2015-11-17 00:18:37,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 328290304 00:18:37 INFO - 2015-11-17 00:18:37,474 DEBUG : BROWSER_OUTPUT: 00:18:40 INFO - 2015-11-17 00:18:40,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:18:40 INFO - 2015-11-17 00:18:40,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 329498624 00:18:40 INFO - 2015-11-17 00:18:40,766 DEBUG : BROWSER_OUTPUT: 00:18:43 INFO - 2015-11-17 00:18:43,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:18:44 INFO - 2015-11-17 00:18:44,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 329535488 00:18:44 INFO - 2015-11-17 00:18:44,073 DEBUG : BROWSER_OUTPUT: 00:18:45 INFO - 2015-11-17 00:18:45,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49736/tests/kraken/driver.html?testName=ai-astar) 00:18:46 INFO - 2015-11-17 00:18:46,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 387821568 00:18:46 INFO - 2015-11-17 00:18:46,075 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,075 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:18:46 INFO - 2015-11-17 00:18:46,075 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:18:46 INFO - 2015-11-17 00:18:46,076 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:18:46 INFO - 2015-11-17 00:18:46,076 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:18:46 INFO - 2015-11-17 00:18:46,076 DEBUG : BROWSER_OUTPUT: |0;ai-astar;105;106;103;107;106;105;96;107;105;106 00:18:46 INFO - 2015-11-17 00:18:46,076 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;151;159;132;149;148;125;165;128 00:18:46 INFO - 2015-11-17 00:18:46,076 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;162;163;162;163;163;160;161 00:18:46 INFO - 2015-11-17 00:18:46,076 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;80;88;85;69;69;72;84;93;73 00:18:46 INFO - 2015-11-17 00:18:46,076 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;100;96;137;93;91;93;131;93;96;143 00:18:46 INFO - 2015-11-17 00:18:46,077 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;124;121;122;122;125;117;124;123;124;130 00:18:46 INFO - 2015-11-17 00:18:46,077 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;127;142;137;134;131;135;136;136;136;135 00:18:46 INFO - 2015-11-17 00:18:46,077 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;105;100;104;105;109;109;108;110 00:18:46 INFO - 2015-11-17 00:18:46,077 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;57;57;59;58;57;59;67;62;62 00:18:46 INFO - 2015-11-17 00:18:46,077 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;68;70;71;69;73;71;74;74 00:18:46 INFO - 2015-11-17 00:18:46,077 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;91;91;92;94;96;95;96;93 00:18:46 INFO - 2015-11-17 00:18:46,078 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;139;143;139;139;137;133;142;136;140 00:18:46 INFO - 2015-11-17 00:18:46,078 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;145;164;165;163;153;164;164;165;153 00:18:46 INFO - 2015-11-17 00:18:46,078 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;68;70;70;72;75;77;76;76 00:18:46 INFO - 2015-11-17 00:18:46,079 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:18:46 INFO - 2015-11-17 00:18:46,079 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:18:46 INFO - 2015-11-17 00:18:46,080 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,926 00:18:46 INFO - 2015-11-17 00:18:46,080 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:18:46 INFO - 2015-11-17 00:18:46,080 DEBUG : BROWSER_OUTPUT: __startTimestamp1447748326074__endTimestamp 00:18:46 INFO - 2015-11-17 00:18:46,080 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,080 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:18:46 INFO - 2015-11-17 00:18:46,080 DEBUG : BROWSER_OUTPUT: Number of tests: 14 00:18:46 INFO - 2015-11-17 00:18:46,080 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,081 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:104.60 Median:106.00 stddev:3.24 (3.1%) stddev-sans-first:3.43 00:18:46 INFO - 2015-11-17 00:18:46,081 DEBUG : BROWSER_OUTPUT: Values: 105.0 106.0 103.0 107.0 106.0 105.0 96.0 107.0 105.0 106.0 00:18:46 INFO - 2015-11-17 00:18:46,081 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,081 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.30 Median:150.00 stddev:14.36 (9.6%) stddev-sans-first:14.59 00:18:46 INFO - 2015-11-17 00:18:46,081 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 151.0 159.0 132.0 149.0 148.0 125.0 165.0 128.0 00:18:46 INFO - 2015-11-17 00:18:46,081 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,082 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 00:18:46 INFO - 2015-11-17 00:18:46,082 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 162.0 163.0 162.0 163.0 163.0 160.0 161.0 00:18:46 INFO - 2015-11-17 00:18:46,082 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,082 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.80 Median:82.00 stddev:8.43 (10.3%) stddev-sans-first:8.83 00:18:46 INFO - 2015-11-17 00:18:46,082 DEBUG : BROWSER_OUTPUT: Values: 75.0 80.0 88.0 85.0 69.0 69.0 72.0 84.0 93.0 73.0 00:18:46 INFO - 2015-11-17 00:18:46,082 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,084 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:93.00 stddev:20.83 (22.4%) stddev-sans-first:21.93 00:18:46 INFO - 2015-11-17 00:18:46,084 DEBUG : BROWSER_OUTPUT: Values: 100.0 96.0 137.0 93.0 91.0 93.0 131.0 93.0 96.0 143.0 00:18:46 INFO - 2015-11-17 00:18:46,084 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,084 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:123.20 Median:124.00 stddev:3.29 (2.7%) stddev-sans-first:3.48 00:18:46 INFO - 2015-11-17 00:18:46,084 DEBUG : BROWSER_OUTPUT: Values: 124.0 121.0 122.0 122.0 125.0 117.0 124.0 123.0 124.0 130.0 00:18:46 INFO - 2015-11-17 00:18:46,084 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,085 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:134.90 Median:136.00 stddev:3.90 (2.9%) stddev-sans-first:2.91 00:18:46 INFO - 2015-11-17 00:18:46,085 DEBUG : BROWSER_OUTPUT: Values: 127.0 142.0 137.0 134.0 131.0 135.0 136.0 136.0 136.0 135.0 00:18:46 INFO - 2015-11-17 00:18:46,085 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,085 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:104.30 Median:109.00 stddev:5.08 (4.7%) stddev-sans-first:4.65 00:18:46 INFO - 2015-11-17 00:18:46,085 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 105.0 100.0 104.0 105.0 109.0 109.0 108.0 110.0 00:18:46 INFO - 2015-11-17 00:18:46,085 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,086 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.70 Median:59.00 stddev:3.16 (5.4%) stddev-sans-first:3.35 00:18:46 INFO - 2015-11-17 00:18:46,086 DEBUG : BROWSER_OUTPUT: Values: 59.0 57.0 57.0 59.0 58.0 57.0 59.0 67.0 62.0 62.0 00:18:46 INFO - 2015-11-17 00:18:46,086 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,086 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:2.46 (3.5%) stddev-sans-first:2.24 00:18:46 INFO - 2015-11-17 00:18:46,086 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 68.0 70.0 71.0 69.0 73.0 71.0 74.0 74.0 00:18:46 INFO - 2015-11-17 00:18:46,086 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,086 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:93.50 stddev:3.65 (3.9%) stddev-sans-first:3.16 00:18:46 INFO - 2015-11-17 00:18:46,087 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 91.0 91.0 92.0 94.0 96.0 95.0 96.0 93.0 00:18:46 INFO - 2015-11-17 00:18:46,087 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,087 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:139.00 stddev:4.67 (3.4%) stddev-sans-first:3.04 00:18:46 INFO - 2015-11-17 00:18:46,089 DEBUG : BROWSER_OUTPUT: Values: 127.0 139.0 143.0 139.0 139.0 137.0 133.0 142.0 136.0 140.0 00:18:46 INFO - 2015-11-17 00:18:46,089 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,089 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.00 Median:164.00 stddev:7.12 (4.3%) stddev-sans-first:7.32 00:18:46 INFO - 2015-11-17 00:18:46,089 DEBUG : BROWSER_OUTPUT: Values: 154.0 145.0 164.0 165.0 163.0 153.0 164.0 164.0 165.0 153.0 00:18:46 INFO - 2015-11-17 00:18:46,089 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,089 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.50 stddev:3.27 (4.5%) stddev-sans-first:3.35 00:18:46 INFO - 2015-11-17 00:18:46,089 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 68.0 70.0 70.0 72.0 75.0 77.0 76.0 76.0 00:18:46 INFO - 2015-11-17 00:18:46,089 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:18:46 INFO - 2015-11-17 00:18:46,090 DEBUG : BROWSER_OUTPUT: 00:18:46 INFO - 2015-11-17 00:18:46,790 INFO : Browser exited with error code: 0 00:18:46 INFO - 2015-11-17 00:18:46,840 INFO : Completed test kraken (00:00:58) 00:18:46 INFO - 2015-11-17 00:18:46,840 INFO : Starting test v8_7 00:18:46 INFO - 2015-11-17 00:18:46,840 DEBUG : operating with platform_type : mac_ 00:18:46 INFO - 2015-11-17 00:18:46,840 INFO : Initialising browser for v8_7 test... 00:18:46 INFO - 2015-11-17 00:18:46,853 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpj7c2G_/profile http://localhost:49736/getInfo.html 00:18:49 INFO - 2015-11-17 00:18:49,118 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:18:49 INFO - 2015-11-17 00:18:49,119 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:18:49 INFO - 2015-11-17 00:18:49,119 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 00:18:49 INFO - 2015-11-17 00:18:49,119 DEBUG : BROWSER_OUTPUT: __metrics 00:18:49 INFO - 2015-11-17 00:18:49,135 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:18:49 INFO - 2015-11-17 00:18:49,850 INFO : Browser initialized. 00:18:49 INFO - 2015-11-17 00:18:49,851 INFO : Running cycle 1/1 for v8_7 test... 00:18:49 INFO - 2015-11-17 00:18:49,851 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/T/tmpj7c2G_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:19:01 INFO - 2015-11-17 00:19:01,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 229318656 00:19:01 INFO - 2015-11-17 00:19:01,853 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49736/tests/v8_7/run.html (next: http://localhost:49736/tests/v8_7/run.html) 00:19:24 INFO - 2015-11-17 00:19:24,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 691093504 00:19:24 INFO - 2015-11-17 00:19:24,672 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,672 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:19:24 INFO - 2015-11-17 00:19:24,672 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:19:24 INFO - 2015-11-17 00:19:24,672 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:19:24 INFO - 2015-11-17 00:19:24,672 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:19:24 INFO - 2015-11-17 00:19:24,672 DEBUG : BROWSER_OUTPUT: |0;Richards;166.8335001668335 00:19:24 INFO - 2015-11-17 00:19:24,672 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;202.02020202020202 00:19:24 INFO - 2015-11-17 00:19:24,672 DEBUG : BROWSER_OUTPUT: |2;Encrypt;349.28396786587496 00:19:24 INFO - 2015-11-17 00:19:24,672 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6172.83950617284 00:19:24 INFO - 2015-11-17 00:19:24,673 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2059.670781893004 00:19:24 INFO - 2015-11-17 00:19:24,673 DEBUG : BROWSER_OUTPUT: |5;Earley;1035.2941176470588 00:19:24 INFO - 2015-11-17 00:19:24,673 DEBUG : BROWSER_OUTPUT: |6;Boyer;14457.142857142857 00:19:24 INFO - 2015-11-17 00:19:24,673 DEBUG : BROWSER_OUTPUT: |7;RegExp;31873.015873015873 00:19:24 INFO - 2015-11-17 00:19:24,673 DEBUG : BROWSER_OUTPUT: |8;Splay;692.0415224913495 00:19:24 INFO - 2015-11-17 00:19:24,673 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6042.168674698795 00:19:24 INFO - 2015-11-17 00:19:24,673 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:19:24 INFO - 2015-11-17 00:19:24,673 DEBUG : BROWSER_OUTPUT: __startTimestamp1447748364664__endTimestamp 00:19:24 INFO - 2015-11-17 00:19:24,673 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,674 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:19:24 INFO - 2015-11-17 00:19:24,674 DEBUG : BROWSER_OUTPUT: Number of tests: 10 00:19:24 INFO - 2015-11-17 00:19:24,674 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,674 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.83 Median:166.83 stddev:0.00 (0.0%) 00:19:24 INFO - 2015-11-17 00:19:24,674 DEBUG : BROWSER_OUTPUT: Values: 166.8 00:19:24 INFO - 2015-11-17 00:19:24,674 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,674 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:202.02 Median:202.02 stddev:0.00 (0.0%) 00:19:24 INFO - 2015-11-17 00:19:24,674 DEBUG : BROWSER_OUTPUT: Values: 202.0 00:19:24 INFO - 2015-11-17 00:19:24,674 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,675 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:349.28 Median:349.28 stddev:0.00 (0.0%) 00:19:24 INFO - 2015-11-17 00:19:24,675 DEBUG : BROWSER_OUTPUT: Values: 349.3 00:19:24 INFO - 2015-11-17 00:19:24,675 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,675 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6172.84 Median:6172.84 stddev:0.00 (0.0%) 00:19:24 INFO - 2015-11-17 00:19:24,675 DEBUG : BROWSER_OUTPUT: Values: 6172.8 00:19:24 INFO - 2015-11-17 00:19:24,675 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,675 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2059.67 Median:2059.67 stddev:0.00 (0.0%) 00:19:24 INFO - 2015-11-17 00:19:24,675 DEBUG : BROWSER_OUTPUT: Values: 2059.7 00:19:24 INFO - 2015-11-17 00:19:24,676 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,676 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1035.29 Median:1035.29 stddev:0.00 (0.0%) 00:19:24 INFO - 2015-11-17 00:19:24,676 DEBUG : BROWSER_OUTPUT: Values: 1035.3 00:19:24 INFO - 2015-11-17 00:19:24,676 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,676 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14457.14 Median:14457.14 stddev:0.00 (0.0%) 00:19:24 INFO - 2015-11-17 00:19:24,676 DEBUG : BROWSER_OUTPUT: Values: 14457.1 00:19:24 INFO - 2015-11-17 00:19:24,676 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,676 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31873.02 Median:31873.02 stddev:0.00 (0.0%) 00:19:24 INFO - 2015-11-17 00:19:24,676 DEBUG : BROWSER_OUTPUT: Values: 31873.0 00:19:24 INFO - 2015-11-17 00:19:24,676 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,677 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:692.04 Median:692.04 stddev:0.00 (0.0%) 00:19:24 INFO - 2015-11-17 00:19:24,677 DEBUG : BROWSER_OUTPUT: Values: 692.0 00:19:24 INFO - 2015-11-17 00:19:24,677 DEBUG : BROWSER_OUTPUT: 00:19:24 INFO - 2015-11-17 00:19:24,677 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6042.17 Median:6042.17 stddev:0.00 (0.0%) 00:19:24 INFO - 2015-11-17 00:19:24,677 DEBUG : BROWSER_OUTPUT: Values: 6042.2 00:19:24 INFO - 2015-11-17 00:19:24,677 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:19:24 INFO - 2015-11-17 00:19:24,677 DEBUG : BROWSER_OUTPUT: 00:19:25 INFO - 2015-11-17 00:19:25,381 INFO : Browser exited with error code: 0 00:19:25 INFO - 2015-11-17 00:19:25,402 INFO : Completed test v8_7 (00:00:38) 00:19:25 INFO - 2015-11-17 00:19:25,702 INFO : Completed test suite (00:20:11) 00:19:25 INFO - 2015-11-17 00:19:25,702 DEBUG : Working with test: dromaeo_css 00:19:25 INFO - 2015-11-17 00:19:25,702 DEBUG : Generating results file: dromaeo_css 00:19:25 INFO - 2015-11-17 00:19:25,703 DEBUG : Working with test: kraken 00:19:25 INFO - 2015-11-17 00:19:25,703 DEBUG : Generating results file: kraken 00:19:25 INFO - 2015-11-17 00:19:25,703 INFO : javascript benchmark 00:19:25 INFO - 2015-11-17 00:19:25,703 DEBUG : Working with test: v8_7 00:19:25 INFO - 2015-11-17 00:19:25,703 DEBUG : Generating results file: v8_7 00:19:25 INFO - 2015-11-17 00:19:25,703 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:19:25 INFO - 2015-11-17 00:19:25,755 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 00:19:25 INFO - 2015-11-17 00:19:25,755 DEBUG : process_Request line: dromaeo_css 6128.46 graph.html#tests=[[72,64,55]] 00:19:25 INFO - 2015-11-17 00:19:25,755 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:19:25 INFO - 2015-11-17 00:19:25,786 DEBUG : process_Request line: kraken 1550.40 graph.html#tests=[[232,64,55]] 00:19:25 INFO - 2015-11-17 00:19:25,786 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:19:25 INFO - 2015-11-17 00:19:25,818 DEBUG : process_Request line: v8_7 17070.16 graph.html#tests=[[230,64,55]] 00:19:25 INFO - 2015-11-17 00:19:25,819 INFO : javascript benchmark 00:19:25 INFO - 2015-11-17 00:19:25,821 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [313.09047217832205, 314.44029627263467, 319.426629200585, 320.0797706593544, 325.8452235188285, 13646.795298070538, 14084.929575352135, 16413.097279649628, 16490.58773530661, 17007.06461144638, 10895.945520272408, 11203.831942520868, 11238.100951923847, 12909.160904541199, 16600.58498537537, 4112.506499220083, 4113.239050775609, 4204.0, 4210.894727631803, 4244.830206791725, 4130.586941305861, 4141.5237247716595, 4175.248455278049, 4189.518205406387, 4194.66442684586, 4128.607782260696, 4131.21506913687, 4138.0, 4153.0863210093885, 4174.603412675791, 4072.429859819613, 4154.376843473503, 4156.91686166278, 4158.08522125132, 4166.020985068521, 3554.7689400189165, 3558.6619271169197, 3563.6970857476886, 3565.554305711786, 3584.5877724061806, 12233.632991010283, 12429.751404971941, 12469.376531173404, 12470.127091103626, 12589.748205035849, 1687.856532194765, 1734.0809371033372, 1739.1304347826087, 1788.5975655477544, 1805.3861687026342, 8824.911750882473, 9084.40951338161, 9132.08679132088, 9149.634014639407, 9229.353945223836, 1423.3310344138238, 1443.7329094117517, 1456.3810380588313, 1472.830624478188, 1521.8325984141736, 48767.756161219324, 49854.50145498535, 50114.749426253, 50433.24350134751, 55376.16935746007, 6129.662868542184, 6131.14164017038, 6131.570790044654, 6172.105044768484, 6204.317525072239, 6623.503237257225, 6656.83357916056, 6752.0, 6987.1266091738535, 6991.161060672752, 5000.024995125988, 5012.949870501248, 5024.522670346311, 5084.669496482717, 5153.665011774223, 5337.786488540415, 5623.578231632644, 5685.744141513642, 5689.061304884731, 5689.630174038674, 2738.87675054623, 2764.226016715323, 2767.0868613357543, 2778.0, 2784.6240757497885, 965.034965034965, 966.8743063401713, 974.055166488505, 974.0940924939732, 1023.9078482936422, 380.1579501404403, 414.7366422321787, 424.92563801334643, 430.56082795548366, 432.86364795089446, 10828.675139745821, 11277.94361028206, 11289.830652540219, 11333.376664283544, 11477.885221147848, 415.5283752940434, 418.19914863037553, 431.35297054418373, 433.78527628823934, 442.7476338487032, 4853.563179313879, 5885.499732522783, 6081.3614570470345, 6127.662978536134, 6227.159333489921, 476112.0, 476288.0, 477034.0, 479879.0, 486196.0, 62676.373236267966, 62996.37003629905, 63646.36353636497, 64036.35963640397, 66650.33349666538, 428.2676622974748, 434.4374035623812, 439.0275539679561, 443.3792690233699, 457.4967535710692, 10148.594056237964, 10252.487375631039, 10370.377777333082, 10402.687919362432, 10431.0, 31818.68181318157, 32900.67099328976, 32923.0, 32998.67001330052, 33537.83231083829, 43145.784271078446, 43302.56697432986, 43559.0, 43919.56080439155, 44274.55725442704, 5624.521915637217, 5853.736581853912, 5878.0, 5890.793822216202, 5900.43945825146, 10775.838362424412, 11062.668119956414, 11084.501197445972, 11176.776464470502, 11193.944030279796, 9157.679481218125, 9544.284178686488, 9565.234781217347, 9674.274429417681, 9680.612775488902, 9004.954975225082, 9247.306452015991, 9260.814783704423, 9303.395279306824, 9319.114684105, 9696.17582505495, 9742.366746161477, 9745.951270243604, 9826.115649591571, 9843.458609776531, 5698.4016678249845, 5833.7666493341485, 5840.2115714378015, 5844.736986835517, 5845.269341332333, 9262.027487114026, 9269.212116970133, 9295.86056209171, 9328.300377471853, 9609.039096090335], "dojo.html": [3036.832974186419, 3054.526548385, 3093.4586447371703, 3182.570353002344, 3209.8555564999574, 4936.456989731127, 5046.167382381903, 5062.012907483037, 5064.949350506494, 5078.085944529983, 4962.801487940487, 4986.875328116799, 5001.0, 5128.076946149691, 5220.92168617471, 4664.0, 4674.532546745315, 4688.906221875561, 4689.601383882374, 4779.378680771512, 4734.053189362124, 4746.715197088186, 4754.191787396151, 4777.80888764449, 4803.663743537953, 4458.77706114693, 4542.159700455426, 4594.494605593365, 4608.23964045932, 4716.669833111683, 4532.0, 4634.281686338623, 4637.026224492861, 4638.2115040443205, 4665.533446655341, 4667.089917466095, 4674.462436819776, 4681.227597446417, 4720.079584481027, 4745.0, 4814.75926203692, 5031.798728050873, 5048.0, 5049.267856160873, 5051.040302342543, 5395.78416863325, 5396.325459317585, 5417.8103766367985, 5418.8916221675345, 5420.403755586883, 5363.302770639831, 5430.185472179165, 5438.972805135989, 5458.863528411782, 5462.6449280797015, 5022.799088036474, 5028.572571331441, 5029.5724863386295, 5032.194848824171, 5036.748162591855, 5509.47659972302, 5510.448955104457, 5512.0905050667, 5515.4760297771645, 5527.474889885454, 5057.115004874132, 5135.3324067870935, 5175.094358487249, 5269.683818970874, 5299.920501192485, 5432.185172224119, 5468.56251499887, 5474.534664553478, 5486.231927530149, 5493.066178749622, 5370.570354371641, 5375.838724838261, 5384.488473595002, 5393.83818485446, 5412.539934105645, 5072.416672082758, 5240.6069544784295, 5247.763850626731, 5272.130098533699, 5319.228711836762, 4131.318332475168, 4146.274401979642, 4152.937705934413, 4155.833766649361, 4207.200631879933, 3807.904802379963, 3813.9427908581392, 3829.885103446901, 3838.3666694995013, 3867.7099217558793, 4995.725235112103, 5005.424376196711, 5120.257562653394, 5125.410577783528, 5142.0, 5444.5916556258435, 5445.673259604358, 5452.154915988028, 5495.120780675153, 5556.611037227355, 5110.488951104934, 5111.897762044739, 5128.9230661540105, 5135.38375394955, 5167.431582525919, 4643.674942753974, 4657.04530571232, 4735.195016847144, 4738.028704115648, 4764.404449443819, 5584.944150558443, 5589.916151257816, 5593.4126916674795, 5636.210930469738, 5638.915416268841, 5454.0, 5456.09974354243, 5459.563234941115, 5459.972700136474, 5492.313460817398, 5385.461453854583, 5513.117901135799, 5523.447655234444, 5526.91709624364, 5690.487856092972, 5394.136938089887, 5402.59480538969, 5420.295361602966, 5429.185622156708, 5439.0, 5432.619716619799, 5458.781648734006, 5459.672419654833, 5501.697406642513, 5522.530584900329, 5097.949020509747, 5209.7395130244095, 5215.374155101412, 5217.739113044408, 5365.678059316453, 5202.687838729688, 5344.732763361739, 5346.037713211659, 5352.170413585744, 5354.732263386893, 5261.079311120615, 5265.262863199232, 5267.394249661338, 5269.736513174403, 5323.600729945192, 5083.389993200692, 5240.34495688039, 5241.659292145999, 5248.2390053442805, 5373.247745315581, 5169.0, 5220.7650655721345, 5224.164133738584, 5266.605004624746, 5274.920876186783], "mootools.html": [1438.5109062918618, 1627.210802760661, 1693.1449617942937, 1706.5221737913384, 1727.3695101288033, 6802.353776391247, 7227.4218062555, 7259.419246460284, 7405.407567394609, 7415.888761668572, 7037.472189585776, 7094.148702155749, 7132.643367831613, 7135.785926422215, 7152.0, 2080.4382816639572, 2092.905819238138, 2107.0097054384414, 2112.2818241797786, 2117.2589593642256, 2104.5264815416563, 2125.1605615781755, 2126.5215326551556, 2141.625215587266, 2145.839062070343, 1837.4212123181155, 1899.886006839594, 1976.8023197680188, 2051.0, 2066.380085974202, 2071.0680193912726, 2088.749350077985, 2099.9685004724943, 2100.5063810004635, 2108.7258656374725, 2122.3420739570784, 2147.9463013424634, 2150.4408853697996, 2153.321703663357, 2165.361218440564, 7472.028636277303, 7553.131389890178, 7571.659275332623, 7574.886376704354, 7583.582902940336, 4537.115262523809, 4624.028953919681, 4634.83778067766, 4640.303954406832, 4683.297505374221, 2650.2844232057428, 2763.5301998660075, 2767.3635063935208, 2769.252301878502, 2777.9444411111867, 814.0028465130168, 829.4484168028254, 852.8081181734123, 854.2909385210261, 854.5470900422786, 10230.283880128394, 10239.232057595711, 10240.846387304122, 10242.334248273839, 10268.640597579124, 3915.334393153171, 4090.8159132839096, 4095.6313931746286, 4103.876883693494, 4119.855805046809, 7987.800304992422, 8226.917730822615, 8366.623501942428, 8381.580920953927, 8382.245597896097, 4351.08627188294, 4371.584699453547, 4382.561743825592, 4405.66957478184, 4410.867673969786, 3927.5483319418063, 3930.9803450982563, 3931.744436611611, 3936.7834769087403, 3953.4069889516227, 3389.881354152642, 3398.5581874356176, 3422.7261819054415, 3444.7071998880374, 3453.430184019659, 1107.1087774341731, 1112.3993043756443, 1117.603250845938, 1125.6060378867494, 1129.6215767717742, 911.1799380557551, 934.5747684803398, 935.1396715022059, 965.6475386484024, 1256.9497220111275, 7162.140543134858, 7169.749058782918, 7196.0285361475535, 7210.89183662235, 7227.27727227273, 617.4905702795212, 618.038949433626, 623.7692053940071, 630.1430055125027, 632.7975047984601, 5555.833325000256, 5578.163275508625, 5603.10350343943, 5614.157876318503, 5644.0, 8313.33493320533, 8386.580670966427, 8488.320934325238, 8570.614322355508, 8577.742667719978, 8411.200935911078, 8448.028476725132, 8488.0, 8514.106018868053, 8527.530985795716, 6701.932980670228, 6754.898676519856, 6767.593944363354, 6805.557638753465, 6814.114165158498, 6578.80263592093, 6580.605163690194, 6582.967085164543, 6586.045023471665, 6604.240512341143, 7417.295356941082, 7536.849263014599, 7541.396688264816, 7616.3906887447765, 7688.077430708351, 7690.126975127181, 7726.381889448943, 7732.729354472566, 7818.960905195438, 7929.048514178336, 5870.853228669147, 6054.848628784315, 6256.405641464054, 6281.497480201664, 6361.268454127835, 6977.232504424408, 7192.172900116344, 7245.673944672608, 7254.637268136466, 7273.0181425509, 6672.0, 6749.5612785168805, 6772.0, 6838.213605435439, 6930.688119034555, 6660.933390666031, 6666.7996171027135, 6713.429358504386, 6727.663616819237, 6747.831304217434, 6712.563683360566, 6762.7294908205085, 6818.113645226089, 6819.795406137824, 6844.041834143124, 6132.0, 6167.444929956326, 6173.104899789416, 6174.135621012972, 6182.938170618237, 6253.218347706536, 6298.653574053471, 6299.181106456314, 6300.086487459384, 6315.115883776183], "ext.html": [531.8989392015517, 533.7464704265475, 540.7944980907255, 554.8929884879665, 564.9830505084849, 29291.0, 30134.54798178029, 30134.94527691534, 30146.24634384136, 30159.69840301599, 30824.229394265156, 38093.0, 38591.61408385915, 38618.8069059655, 38786.0, 8535.87196192056, 8627.180417860325, 8631.65473381064, 8646.697365592205, 8647.351448641346, 7841.882371764428, 8025.478343907656, 8472.576371181447, 8533.317334613215, 8563.272121869648, 10370.740731481736, 10513.684589462327, 10551.050405463508, 10558.52486638103, 10579.629712960048, 10138.543765530532, 10247.795044099152, 10288.485575721259, 10298.227632927485, 10316.123129533999, 7703.0, 7898.210178982114, 10082.495875206283, 10157.695269141937, 10418.114460270886, 36289.45565816515, 36725.26549468996, 36759.0, 36903.63096369029, 36909.26181476355, 2679.423923856361, 2751.6697996240378, 2815.3806162644187, 2904.0561817409425, 3095.4428202923464, 25385.111521096856, 25689.48621027569, 25721.614175787377, 25943.0, 26667.0, 2270.4550907782013, 2299.678045073691, 2312.5259321838985, 2326.7673232676766, 2378.63131214662, 242407.0, 242497.0, 242498.0, 243876.0, 245826.0, 50958.49041509537, 51289.743551282, 51395.74302128465, 51534.74232628813, 51580.22629660558, 47705.522944770106, 48313.0, 48315.0, 48386.27420588694, 56914.430855690916, 15204.771928421083, 16070.839291606935, 16079.276432560562, 16080.517584472485, 16101.033937963759, 11412.258203216765, 11555.306681599131, 11595.420228988516, 11622.94188529052, 11646.592369267035, 17580.824191757918, 17614.29542818273, 17635.382761603283, 17667.823321766875, 17717.822821771617, 8133.59332033396, 8381.539015354092, 8431.409801313972, 8450.71830605733, 8457.365697572706, 882.6822343956171, 909.8999110097884, 961.1589858873485, 1016.786474840277, 1034.3483605328595, 26214.86892565563, 26604.14216516843, 26822.329441763723, 26885.462290754465, 26944.0, 1000.3197825478599, 1014.9289549731448, 1024.4826362686795, 1052.5316234275674, 1188.0733028237987, 12483.438245278985, 12725.0, 12746.661600531996, 12754.55359062447, 12794.936025319814, 226735.0, 229916.0, 230125.0, 230141.0, 233311.0, 44528.0, 44881.55118448839, 44965.10069798586, 44978.0, 45279.54720452819, 1294.087668193921, 1306.0661626936785, 1335.2188969452784, 1336.659151916255, 1338.0232430325916, 24313.635295470227, 25053.624195636716, 25110.0, 25120.12079577206, 25155.119570814935, 42177.0, 42191.15617687568, 42199.57800421956, 42286.0, 42346.78826605847, 262941.0, 269008.0, 271122.0, 301183.0, 301832.0, 29162.708372916, 29443.85278073596, 29548.0, 29572.408551829274, 29577.0, 36262.63737362593, 37097.25805483821, 37446.812765935996, 37682.8115859419, 38058.0485487865, 30642.693573064877, 32216.355672885944, 32334.676653233168, 32584.0, 32630.83684581562, 31968.36063278675, 31973.68026319707, 31983.84008080038, 32250.193745156557, 32257.35485290328, 31850.149573072627, 32163.195920101247, 32201.51697724583, 32452.51321230136, 32513.0, 27553.448931020866, 28339.574906376834, 28772.42455150927, 28987.42025159527, 29380.853095734383, 21412.166480268363, 22087.889560552096, 22434.887825560767, 22476.77523224747, 22504.212352568236], "prototype.html": [296.36134130947806, 301.7314590014887, 301.78422427964, 302.8818760683333, 303.4886216724819, 5739.827805165852, 5850.2394688690465, 5880.26496687914, 5898.88202235955, 5898.88202235955, 5762.078067509199, 5836.854078648036, 5869.295684517853, 5897.144913987469, 5910.202122713433, 4476.283794592866, 4494.97752511237, 4497.168023915569, 4502.324651302298, 4522.118186953546, 4327.0047888985555, 4394.209042372372, 4509.751963641998, 4519.4124763780665, 4528.932066018996, 4166.333386658135, 4376.868693939187, 4398.86803395897, 4431.468223813147, 4480.372747815292, 4433.822647094113, 4434.512203657595, 4448.599626033656, 4452.68831181819, 4457.509673935864, 3817.026658202141, 3831.1954489557224, 3831.597682243352, 3832.118612719062, 3856.9228615427814, 5538.529225015878, 5737.598368114233, 5741.0, 5745.942540574624, 5773.393793651648, 5061.190209566452, 5063.139266324733, 5080.847574572768, 5082.822101226477, 5084.822031228926, 6192.071189321593, 6193.87612247757, 6198.0, 6205.658688772116, 6228.844278893064, 3991.8004099794894, 4088.34586466164, 4090.611391917763, 4096.754194748325, 4173.39485774564, 6525.608463492158, 6528.51036172289, 6536.150300460958, 6550.181227346582, 6559.508036897252, 4255.425517555091, 4267.125239325931, 4274.252005898955, 4280.700350975402, 4290.29210180323, 4323.913521729548, 4333.631641310524, 4338.717983331074, 4342.0, 4348.67384946124, 4873.634477414208, 5050.3182070420025, 5065.240213967934, 5070.188769796815, 5085.821996230115, 6191.4118158774845, 6199.039148931923, 6202.875942481125, 6224.066390041439, 6226.688665566703, 1513.1677577332423, 1536.6093685214898, 1538.6538028943621, 1539.2150003498073, 1544.3050627217797, 983.9950800245953, 1003.7590978165188, 1013.852991316255, 1014.1531820929459, 1032.5456799008412, 5969.522438204933, 5969.522438204933, 5984.790532331347, 5986.521078313812, 5989.251343582052, 6437.710303036374, 6446.580972236789, 6448.161738973997, 6461.256955450183, 6509.316521765241, 5980.581359304807, 5987.341392446828, 5990.400959903975, 5997.640141591519, 6011.008183649737, 3399.167204035027, 3498.0, 3513.648635136517, 3515.068506845688, 3518.1556426457464, 6717.328267173243, 6718.395344419026, 6721.092652491949, 6724.831879203059, 6759.459243260528, 6680.298568650222, 6685.130932978682, 6695.163104611924, 6703.564268322543, 6712.194536655535, 6459.321771214049, 6691.330866913269, 6694.09629699994, 6704.161979752531, 6708.597484150967, 6506.479481641552, 6510.7721229756735, 6513.804585862432, 6519.771807986698, 6524.543281970216, 6104.6642434664745, 6306.999999999816, 6308.558400911892, 6317.7157027932935, 6390.936090639034, 6571.704273307808, 6582.144321238208, 6709.899351509829, 6715.26132125456, 6736.7642132525125, 4112.794360281914, 4199.790010499524, 4202.096549241927, 4202.2646036944025, 4244.2996905510245, 6251.937480625135, 6446.09754634361, 6460.192475940507, 6492.935070649422, 6498.707558159799, 6305.1172835803945, 6312.242530896322, 6325.588836725598, 6326.525510586633, 6338.461230795434, 6259.499240060875, 6276.529260305587, 6279.372062793684, 6280.434760871543, 6287.2140982377205, 5983.0, 6166.136740856194, 6178.567500275118, 6212.285587157354, 6212.689365531795, 6309.779157729457, 6322.114903913548, 6325.430711236011, 6343.904841427475, 6345.777897773741, 6186.907196392148, 6254.9687251563455, 6255.030470277115, 6259.593126446766, 6259.718312676032], "yui.html": [618.7092066728636, 681.9011243369712, 694.871448781975, 699.0841996983949, 709.0427922304889, 10410.791784164312, 10794.622188223413, 11014.944925275382, 11131.833022504668, 11160.999999999989, 11115.944420277887, 11175.497102630381, 11203.887961120387, 11207.887921120786, 11247.943760281207, 641.9632293845452, 646.9450096741782, 794.6980147543925, 811.1037303779298, 811.9553424561647, 663.6980174020833, 796.7012370361115, 814.5519964019795, 820.6061090676479, 821.1829229916242, 824.3446460064233, 845.1970627903486, 845.3364109174299, 846.3609974469267, 846.7925358287198, 671.2012704881224, 682.7132604306204, 819.6762278899802, 837.1921096142222, 838.0906716212917, 610.8289678889873, 616.6454288783967, 617.2623714660982, 617.6139912554653, 617.728199592178, 9999.0, 10114.0, 10126.088652021353, 10134.442605656686, 10157.339772914736, 8871.512066836322, 9073.773155671095, 9109.134632209929, 9294.488803115826, 9522.0, 8271.13153118926, 8368.874466883002, 8387.916120838774, 8472.957635211846, 8933.15135062168, 2584.5477041517847, 2632.9868350658317, 2742.149933520615, 2765.391613844951, 2768.4463107378606, 43767.56232437699, 44361.334579981005, 44466.555334446886, 44756.3286550702, 44907.550924490664, 6118.082287656887, 6265.62406255617, 6406.071119687619, 6514.218293804774, 6600.075989361493, 11049.0, 11118.0, 11163.553457861595, 11203.383813890152, 11235.494402751896, 5368.597355198376, 5376.677399355973, 5386.703731294817, 5487.396386397493, 5520.089185284383, 3366.5286859839152, 3418.384690755638, 3463.0264837268505, 3483.965160348415, 3656.634336566322, 2493.426511902236, 2511.259178542334, 2513.9120130795336, 2516.8993240270183, 2518.1690042286, 370.5423801605016, 371.68406854173736, 372.5510759534754, 373.77947011263484, 377.3905143193777, 465.9277811939155, 520.7396301849076, 534.8636097795037, 584.1243350370323, 589.669784920446, 6889.276625954303, 7041.295870413021, 7359.411247100219, 7483.0, 7505.061867266591, 530.9256704061435, 530.9480294993143, 562.4291344285554, 564.2326436046973, 575.1832397994857, 3212.550242965987, 3267.575215222006, 3288.342331533655, 3288.8848890288723, 3334.899953001414, 55916.44083559194, 58616.413835861946, 58634.12048819271, 59565.40434595685, 59578.70210648919, 46703.0, 46794.298085528746, 47486.0, 48712.0, 49356.75321623441, 43154.13691726148, 43249.783751081675, 43473.565264347584, 45252.54747452549, 45751.08497830091, 7740.806479838049, 7890.210978902293, 7992.200779921961, 8061.072976607531, 8215.507069575844, 32123.357532848746, 32882.20501257324, 32938.0, 33141.0, 33596.160095997795, 42578.78710606427, 44339.55660443483, 44377.33433998557, 44522.77738611286, 44832.551674482835, 6815.284395138439, 6942.930570694229, 7032.613206273704, 7112.644367781693, 7125.964370178116, 10109.797804044025, 10695.625653102104, 10863.891361086287, 11042.889571104508, 11461.140414469115, 9925.602975880884, 10035.498225088862, 10302.22733294991, 10378.948105259426, 10734.67795966091, 9840.901590984286, 9886.406815591088, 10239.129673977795, 10342.069213770797, 10622.20333474977, 6063.423974722395, 9137.862932056158, 9825.95087024589, 10145.594176233164, 10189.133923616575, 8457.61940712657, 8522.105178956368, 8743.519106448952, 8837.955810220908, 8901.376903616685, 8380.287675547646, 8562.785930351542, 8578.871316930376, 8723.65105395777, 8909.465432074096]}, "summary": {"lowerIsBetter": false, "suite": 6128.458887268784, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6130.270886403619, "unit": "ms", "value": 6130.270886403619}, "dojo.html": {"lowerIsBetter": false, "filtered": 5010.243068803002, "unit": "ms", "value": 5010.243068803002}, "mootools.html": {"lowerIsBetter": false, "filtered": 4133.753960735987, "unit": "ms", "value": 4133.753960735987}, "ext.html": {"lowerIsBetter": false, "filtered": 16865.33816609387, "unit": "ms", "value": 16865.33816609387}, "prototype.html": {"lowerIsBetter": false, "filtered": 4658.965417984457, "unit": "ms", "value": 4658.965417984457}, "yui.html": {"lowerIsBetter": false, "filtered": 5310.090190198254, "unit": "ms", "value": 5310.090190198254}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0027"}, "testrun": {"date": 1447747154, "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": "20151116221703", "branch": "Fx-Team", "revision": "996fabe1edaa17ae416baf84089baa2c50076707"}}, {"talos_counters": {}, "results": {"audio-dft": [161.0, 162.0, 161.0, 162.0, 163.0, 162.0, 163.0, 163.0, 160.0, 161.0], "ai-astar": [105.0, 106.0, 103.0, 107.0, 106.0, 105.0, 96.0, 107.0, 105.0, 106.0], "imaging-gaussian-blur": [124.0, 121.0, 122.0, 122.0, 125.0, 117.0, 124.0, 123.0, 124.0, 130.0], "audio-beat-detection": [156.0, 130.0, 151.0, 159.0, 132.0, 149.0, 148.0, 125.0, 165.0, 128.0], "json-stringify-tinderbox": [67.0, 69.0, 68.0, 70.0, 71.0, 69.0, 73.0, 71.0, 74.0, 74.0], "stanford-crypto-pbkdf2": [154.0, 145.0, 164.0, 165.0, 163.0, 153.0, 164.0, 164.0, 165.0, 153.0], "json-parse-financial": [59.0, 57.0, 57.0, 59.0, 58.0, 57.0, 59.0, 67.0, 62.0, 62.0], "stanford-crypto-sha256-iterative": [70.0, 70.0, 68.0, 70.0, 70.0, 72.0, 75.0, 77.0, 76.0, 76.0], "audio-fft": [75.0, 80.0, 88.0, 85.0, 69.0, 69.0, 72.0, 84.0, 93.0, 73.0], "imaging-darkroom": [127.0, 142.0, 137.0, 134.0, 131.0, 135.0, 136.0, 136.0, 136.0, 135.0], "stanford-crypto-ccm": [127.0, 139.0, 143.0, 139.0, 139.0, 137.0, 133.0, 142.0, 136.0, 140.0], "audio-oscillator": [100.0, 96.0, 137.0, 93.0, 91.0, 93.0, 131.0, 93.0, 96.0, 143.0], "stanford-crypto-aes": [86.0, 86.0, 91.0, 91.0, 92.0, 94.0, 96.0, 95.0, 96.0, 93.0], "imaging-desaturate": [97.0, 96.0, 105.0, 100.0, 104.0, 105.0, 109.0, 109.0, 108.0, 110.0]}, "summary": {"lowerIsBetter": true, "suite": 1550.4, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 78.8, "unit": "ms", "value": 78.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 159.0, "unit": "ms", "value": 159.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.3, "unit": "ms", "value": 144.3}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 137.5, "unit": "ms", "value": 137.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 134.9, "unit": "ms", "value": 134.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.7, "unit": "ms", "value": 59.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 107.3, "unit": "ms", "value": 107.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 104.6, "unit": "ms", "value": 104.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.8, "unit": "ms", "value": 161.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 72.4, "unit": "ms", "value": 72.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 70.6, "unit": "ms", "value": 70.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 123.2, "unit": "ms", "value": 123.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 92.0, "unit": "ms", "value": 92.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 104.3, "unit": "ms", "value": 104.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0027"}, "testrun": {"date": 1447747154, "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": "20151116221703", "branch": "Fx-Team", "revision": "996fabe1edaa17ae416baf84089baa2c50076707"}}, {"talos_counters": {}, "results": {"DeltaBlue": [202.02020202020202], "Encrypt": [349.28396786587496], "NavierStokes": [6042.168674698795], "Decrypt": [6172.83950617284], "Splay": [692.0415224913495], "Richards": [166.8335001668335], "RegExp": [31873.015873015873], "Earley": [1035.2941176470588], "Boyer": [14457.142857142857], "RayTrace": [2059.670781893004]}, "summary": {"lowerIsBetter": false, "suite": 17070.160452040913, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 327.2840999999999, "unit": "score", "value": 327.2840999999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 762.0762030000001, "unit": "score", "value": 762.0762030000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 245.60717846460636, "unit": "score", "value": 245.60717846460636}, "Decrypt": {"lowerIsBetter": false, "filtered": 43.12132199999997, "unit": "score", "value": 43.12132199999997}, "Splay": {"lowerIsBetter": false, "filtered": 117.75449499999998, "unit": "score", "value": 117.75449499999998}, "RegExp": {"lowerIsBetter": false, "filtered": 28.58170069721115, "unit": "score", "value": 28.58170069721115}, "Richards": {"lowerIsBetter": false, "filtered": 211.6001880000001, "unit": "score", "value": 211.6001880000001}, "Earley": {"lowerIsBetter": false, "filtered": 643.7426704545455, "unit": "score", "value": 643.7426704545455}, "Boyer": {"lowerIsBetter": false, "filtered": 46.0992193675889, "unit": "score", "value": 46.0992193675889}, "RayTrace": {"lowerIsBetter": false, "filtered": 359.27537862137854, "unit": "score", "value": 359.27537862137854}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0027"}, "testrun": {"date": 1447747154, "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": "20151116221703", "branch": "Fx-Team", "revision": "996fabe1edaa17ae416baf84089baa2c50076707"}}] 00:19:25 INFO - RETURN: dromaeo_css: 6128.46 00:19:25 INFO - RETURN: kraken: 1550.40 00:19:25 INFO - RETURN: v8_7: 17070.16 00:19:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "17070.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1550.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6128.46"}}} 00:19:25 INFO - Return code: 0 00:19:25 INFO - # TBPL SUCCESS # 00:19:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:19:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:19:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:19:25 INFO - 2015-11-17 00:19:25.912 screenresolution[1965:14574] starting screenresolution argv=screenresolution get 00:19:25 INFO - 2015-11-17 00:19:25.915 screenresolution[1965:14574] Display 0: 1600x1200x32@60 00:19:25 INFO - 2015-11-17 00:19:25.921 screenresolution[1966:14578] starting screenresolution argv=screenresolution list 00:19:25 INFO - Available Modes on Display 0 00:19:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:19:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:19:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:19:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:19:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:19:26 INFO - Intel HD Graphics 3000: 00:19:26 INFO - Chipset Model: Intel HD Graphics 3000 00:19:26 INFO - Type: GPU 00:19:26 INFO - Bus: Built-In 00:19:26 INFO - VRAM (Total): 512 MB 00:19:26 INFO - VRAM (Dynamic, Max): 10 00:19:26 INFO - Vendor: Intel (0x8086) 00:19:26 INFO - Device ID: 0x0116 00:19:26 INFO - Revision ID: 0x0009 00:19:26 INFO - Displays: 00:19:26 INFO - Display: 00:19:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:19:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:19:26 INFO - Display Serial Number: 1600x1200 60 00:19:26 INFO - Main Display: Yes 00:19:26 INFO - Mirror: Off 00:19:26 INFO - Online: Yes 00:19:26 INFO - Rotation: Supported 00:19:26 INFO - Return code: 0 00:19:26 INFO - Running post-action listener: _resource_record_post_action 00:19:26 INFO - Running post-run listener: _resource_record_post_run 00:19:27 INFO - Total resource usage - Wall time: 1251s; CPU: 30.0%; Read bytes: 6373376; Write bytes: 690527232; Read time: 2249; Write time: 39827 00:19:27 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 338940416; Write bytes: 334456832; Read time: 32910; Write time: 5957 00:19:27 INFO - run-tests - Wall time: 1213s; CPU: 30.0%; Read bytes: 6373376; Write bytes: 344757248; Read time: 2249; Write time: 33272 00:19:27 INFO - Running post-run listener: _upload_blobber_files 00:19:27 INFO - Blob upload gear active. 00:19:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 00:19:27 INFO - Copying logs to upload dir... 00:19:27 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.772539 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-17 00:19:27.339404) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 00:19:27.342729) ========= 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.U3DaJEedFW/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.fiK7OD8D79/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009974 build_url: 'https://queue.taskcluster.net/v1/task/bc12LPlBTgWw017NDBOmpQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 00:19:27.372178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 00:19:27.372591) ========= 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.U3DaJEedFW/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.fiK7OD8D79/Listeners TMPDIR=/var/folders/gd/qnn56ddx3f53zdyq1jjd6x9400000w/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.005185 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 00:19:27.425972) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 00:19:27.426829) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 00:19:27.427513) ========= ========= Total master_lag: 1.27 =========