builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0026 starttime: 1447722993.1 results: success (0) buildid: 20151116145334 builduid: 380466860f574d0bb1a6b4adc16df426 revision: 3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.098071) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.098526) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.098828) ========= 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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.006308 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.125493) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.128934) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.146289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.146688) ========= 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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.005451 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.195386) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.198725) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.199094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.199369) ========= 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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 17:16:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.13G=0s 2015-11-16 17:16:33 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110638 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.328655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.329062) ========= 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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.020877 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.380456) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.380909) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33 --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 3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N9WOJVQ63p/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.TbrtN6QL5U/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 17:16:33,458 truncating revision to first 12 chars 2015-11-16 17:16:33,458 Setting DEBUG logging. 2015-11-16 17:16:33,458 attempt 1/10 2015-11-16 17:16:33,458 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3dcb690e49f2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 17:16:33,726 unpacking tar archive at: fx-team-3dcb690e49f2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523335 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.921742) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.922086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.939718) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.940082) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 17:16:33.940522) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-16 17:16:33.940815) ========= /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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 17:16:34 INFO - MultiFileLogger online at 20151116 17:16:34 in /builds/slave/test 17:16:34 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 17:16:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:16:34 INFO - {'append_to_log': False, 17:16:34 INFO - 'base_work_dir': '/builds/slave/test', 17:16:34 INFO - 'blob_upload_branch': 'Fx-Team', 17:16:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:16:34 INFO - 'branch': 'Fx-Team', 17:16:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:16:34 INFO - 'config_files': ('talos/mac_config.py',), 17:16:34 INFO - 'default_actions': ('clobber', 17:16:34 INFO - 'read-buildbot-config', 17:16:34 INFO - 'download-and-extract', 17:16:34 INFO - 'populate-webroot', 17:16:34 INFO - 'create-virtualenv', 17:16:34 INFO - 'install', 17:16:34 INFO - 'run-tests'), 17:16:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:16:34 INFO - 'download_minidump_stackwalk': True, 17:16:34 INFO - 'download_symbols': 'ondemand', 17:16:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:16:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:16:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:16:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:16:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:16:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:16:34 INFO - 'installer_path': 'installer.exe', 17:16:34 INFO - 'log_level': 'info', 17:16:34 INFO - 'log_name': 'talos', 17:16:34 INFO - 'log_to_console': True, 17:16:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:16:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:16:34 INFO - 'opt_config_files': (), 17:16:34 INFO - 'pip_index': False, 17:16:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:16:34 INFO - 'cmd': ('bash', 17:16:34 INFO - '-c', 17:16:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:16:34 INFO - 'enabled': True, 17:16:34 INFO - 'halt_on_failure': False, 17:16:34 INFO - 'name': 'check_screen_resolution'},), 17:16:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:16:34 INFO - 'cmd': ('bash', 17:16:34 INFO - '-c', 17:16:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:16:34 INFO - 'enabled': True, 17:16:34 INFO - 'halt_on_failure': False, 17:16:34 INFO - 'name': 'check_screen_resolution'},), 17:16:34 INFO - 'run_cmd_checks_enabled': True, 17:16:34 INFO - 'sps_profile': False, 17:16:34 INFO - 'sps_profile_interval': 0, 17:16:34 INFO - 'suite': 'dromaeojs', 17:16:34 INFO - 'system_bits': '64', 17:16:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:16:34 INFO - 'title': 't-yosemite-r5-0026', 17:16:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:16:34 INFO - 'use_talos_json': True, 17:16:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:16:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:16:34 INFO - 'work_dir': 'build'} 17:16:34 INFO - ##### 17:16:34 INFO - ##### Running clobber step. 17:16:34 INFO - ##### 17:16:34 INFO - Running pre-action listener: _resource_record_pre_action 17:16:34 INFO - Running main action method: clobber 17:16:34 INFO - rmtree: /builds/slave/test/build 17:16:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:16:36 INFO - Running post-action listener: _resource_record_post_action 17:16:36 INFO - ##### 17:16:36 INFO - ##### Running read-buildbot-config step. 17:16:36 INFO - ##### 17:16:36 INFO - Running pre-action listener: _resource_record_pre_action 17:16:36 INFO - Running main action method: read_buildbot_config 17:16:36 INFO - Using buildbot properties: 17:16:36 INFO - { 17:16:36 INFO - "properties": { 17:16:36 INFO - "buildnumber": 1240, 17:16:36 INFO - "product": "firefox", 17:16:36 INFO - "script_repo_revision": "production", 17:16:36 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 17:16:36 INFO - "repository": "", 17:16:36 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 17:16:36 INFO - "buildid": "20151116145334", 17:16:36 INFO - "slavename": "t-yosemite-r5-0026", 17:16:36 INFO - "pgo_build": "False", 17:16:36 INFO - "basedir": "/builds/slave/test", 17:16:36 INFO - "project": "", 17:16:36 INFO - "platform": "yosemite", 17:16:36 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:16:36 INFO - "slavebuilddir": "test", 17:16:36 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:16:36 INFO - "branch": "fx-team", 17:16:36 INFO - "repo_path": "integration/fx-team", 17:16:36 INFO - "stage_platform": "macosx64", 17:16:36 INFO - "builduid": "380466860f574d0bb1a6b4adc16df426", 17:16:36 INFO - "revision": "3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33" 17:16:36 INFO - }, 17:16:36 INFO - "sourcestamp": { 17:16:36 INFO - "repository": "", 17:16:36 INFO - "hasPatch": false, 17:16:36 INFO - "project": "", 17:16:36 INFO - "branch": "fx-team-macosx64-talos", 17:16:36 INFO - "changes": [ 17:16:36 INFO - { 17:16:36 INFO - "category": null, 17:16:36 INFO - "files": [ 17:16:36 INFO - { 17:16:36 INFO - "url": null, 17:16:36 INFO - "name": "https://queue.taskcluster.net/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 17:16:36 INFO - } 17:16:36 INFO - ], 17:16:36 INFO - "repository": "", 17:16:36 INFO - "rev": "3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33", 17:16:36 INFO - "who": "archaeopteryx@coole-files.de", 17:16:36 INFO - "when": 1447719458, 17:16:36 INFO - "number": 6668990, 17:16:36 INFO - "comments": "Bug 1224834 - Remove infinite improbability drive. r=Gijs", 17:16:36 INFO - "project": "", 17:16:36 INFO - "at": "Mon 16 Nov 2015 16:17:38", 17:16:36 INFO - "branch": "fx-team-macosx64-talos", 17:16:36 INFO - "revlink": "", 17:16:36 INFO - "properties": [ 17:16:36 INFO - [ 17:16:36 INFO - "buildid", 17:16:36 INFO - "20151116145334", 17:16:36 INFO - "Change" 17:16:36 INFO - ], 17:16:36 INFO - [ 17:16:36 INFO - "builduid", 17:16:36 INFO - "380466860f574d0bb1a6b4adc16df426", 17:16:36 INFO - "Change" 17:16:36 INFO - ], 17:16:36 INFO - [ 17:16:36 INFO - "pgo_build", 17:16:36 INFO - "False", 17:16:36 INFO - "Change" 17:16:36 INFO - ] 17:16:36 INFO - ], 17:16:36 INFO - "revision": "3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33" 17:16:36 INFO - } 17:16:36 INFO - ], 17:16:36 INFO - "revision": "3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33" 17:16:36 INFO - } 17:16:36 INFO - } 17:16:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 17:16:36 INFO - Running post-action listener: _resource_record_post_action 17:16:36 INFO - ##### 17:16:36 INFO - ##### Running download-and-extract step. 17:16:36 INFO - ##### 17:16:36 INFO - Running pre-action listener: _resource_record_pre_action 17:16:36 INFO - Running main action method: download_and_extract 17:16:36 INFO - mkdir: /builds/slave/test/build/tests 17:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:36 INFO - https://queue.taskcluster.net/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/test_packages.json 17:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/test_packages.json 17:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:16:37 INFO - Downloaded 1149 bytes. 17:16:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:16:37 INFO - Using the following test package requirements: 17:16:37 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:16:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:16:37 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 17:16:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:16:37 INFO - u'jsshell-mac.zip'], 17:16:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:16:37 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 17:16:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:16:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:16:37 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 17:16:37 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:16:37 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 17:16:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:16:37 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 17:16:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:16:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:16:37 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 17:16:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:37 INFO - https://queue.taskcluster.net/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:16:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:16:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:16:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/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 17:16:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/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 17:16:38 INFO - Downloaded 17460635 bytes. 17:16:38 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 17:16:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:16:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:16:43 INFO - Return code: 0 17:16:43 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 17:16:43 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')]} 17:16:43 INFO - https://queue.taskcluster.net/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/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 17:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/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 17:16:44 INFO - Downloaded 17460635 bytes. 17:16:44 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 17:16:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:16:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:16:50 INFO - Return code: 0 17:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:50 INFO - https://queue.taskcluster.net/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:16:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:16:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:16:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/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 17:16:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/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 17:16:51 INFO - Downloaded 11131693 bytes. 17:16:51 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 17:16:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:16:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 17:16:51 INFO - Return code: 0 17:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:51 INFO - https://queue.taskcluster.net/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:16:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:16:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:16:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 17:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/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 17:16:54 INFO - Downloaded 108686725 bytes. 17:16:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:16:54 INFO - mkdir: /builds/slave/test/properties 17:16:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:16:54 INFO - Writing to file /builds/slave/test/properties/build_url 17:16:54 INFO - Contents: 17:16:54 INFO - build_url:https://queue.taskcluster.net/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:16:54 INFO - Running post-action listener: _resource_record_post_action 17:16:54 INFO - Running post-action listener: set_extra_try_arguments 17:16:54 INFO - ##### 17:16:54 INFO - ##### Running populate-webroot step. 17:16:54 INFO - ##### 17:16:54 INFO - Running pre-action listener: _resource_record_pre_action 17:16:54 INFO - Running main action method: populate_webroot 17:16:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:16:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:16:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:16:54 INFO - '../fennec_ids.txt'], 17:16:54 INFO - 'tests': ['tcheck2']}, 17:16:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:16:54 INFO - '--tppagecycles', 17:16:54 INFO - '7'], 17:16:54 INFO - 'tests': ['tsvgm']}}, 17:16:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:16:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:16:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:16:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:16:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:16:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:16:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:54 INFO - 'talos_options': ['--e10s'], 17:16:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:16:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:54 INFO - 'tests': ['damp', 'tps']}, 17:16:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:54 INFO - 'talos_options': ['--e10s'], 17:16:54 INFO - 'tests': ['damp', 'tps']}, 17:16:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:16:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:16:54 INFO - 'other': {'tests': ['a11yr', 17:16:54 INFO - 'ts_paint', 17:16:54 INFO - 'tpaint', 17:16:54 INFO - 'sessionrestore', 17:16:54 INFO - 'sessionrestore_no_auto_restore']}, 17:16:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:16:54 INFO - 'tests': ['a11yr', 17:16:54 INFO - 'ts_paint', 17:16:54 INFO - 'tpaint', 17:16:54 INFO - 'sessionrestore', 17:16:54 INFO - 'sessionrestore_no_auto_restore']}, 17:16:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:16:54 INFO - 'tests': ['a11yr', 17:16:54 INFO - 'ts_paint', 17:16:54 INFO - 'tpaint', 17:16:54 INFO - 'sessionrestore', 17:16:54 INFO - 'sessionrestore_no_auto_restore']}, 17:16:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:16:54 INFO - 'tests': ['a11yr', 17:16:54 INFO - 'ts_paint', 17:16:54 INFO - 'tpaint', 17:16:54 INFO - 'sessionrestore', 17:16:54 INFO - 'sessionrestore_no_auto_restore']}, 17:16:54 INFO - 'other_l64': {'tests': ['a11yr', 17:16:54 INFO - 'ts_paint', 17:16:54 INFO - 'tpaint', 17:16:54 INFO - 'sessionrestore', 17:16:54 INFO - 'sessionrestore_no_auto_restore']}, 17:16:54 INFO - 'other_nol64': {'tests': ['a11yr', 17:16:54 INFO - 'ts_paint', 17:16:54 INFO - 'tpaint', 17:16:54 INFO - 'sessionrestore', 17:16:54 INFO - 'sessionrestore_no_auto_restore']}, 17:16:54 INFO - 'svgr': {'tests': ['tsvgx', 17:16:54 INFO - 'tsvgr_opacity', 17:16:54 INFO - 'tart', 17:16:54 INFO - 'tscrollx', 17:16:54 INFO - 'cart']}, 17:16:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:16:54 INFO - 'tests': ['tsvgx', 17:16:54 INFO - 'tsvgr_opacity', 17:16:54 INFO - 'tart', 17:16:54 INFO - 'tscrollx', 17:16:54 INFO - 'cart']}, 17:16:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:54 INFO - 'tests': ['tp5o']}, 17:16:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:54 INFO - 'talos_options': ['--e10s'], 17:16:54 INFO - 'tests': ['tp5o']}, 17:16:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:54 INFO - 'talos_options': ['--xperf_path', 17:16:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:54 INFO - 'tests': ['tp5n']}, 17:16:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:16:54 INFO - 'talos_options': ['--e10s', 17:16:54 INFO - '--xperf_path', 17:16:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:16:54 INFO - 'tests': ['tp5n']}}, 17:16:54 INFO - 'talos.zip': {'path': '', 17:16:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:16:54 INFO - Running post-action listener: _resource_record_post_action 17:16:54 INFO - ##### 17:16:54 INFO - ##### Running create-virtualenv step. 17:16:54 INFO - ##### 17:16:54 INFO - Running pre-action listener: _resource_record_pre_action 17:16:54 INFO - Running main action method: create_virtualenv 17:16:54 INFO - Creating virtualenv /builds/slave/test/build/venv 17:16:54 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 17:16:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:16:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:16:55 INFO - Using real prefix '/tools/python27' 17:16:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:16:55 INFO - Installing distribute.............................................................................................................................................................................................done. 17:16:59 INFO - Installing pip.................done. 17:16:59 INFO - Return code: 0 17:16:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:16:59 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')]} 17:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:59 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')]} 17:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:16:59 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 0x1021f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44b565de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021159f0>, '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 0x101e75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021098c8>, '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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 17:16:59 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 17:16:59 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 17:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9WOJVQ63p/Render', 17:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:16:59 INFO - 'HOME': '/Users/cltbld', 17:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:16:59 INFO - 'LOGNAME': 'cltbld', 17:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:16:59 INFO - 'MOZ_NO_REMOTE': '1', 17:16:59 INFO - 'NO_EM_RESTART': '1', 17:16:59 INFO - 'PAGER': '/bin/cat', 17:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:16:59 INFO - 'PWD': '/builds/slave/test', 17:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:16:59 INFO - 'SHELL': '/bin/bash', 17:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TbrtN6QL5U/Listeners', 17:16:59 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 17:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:16:59 INFO - 'USER': 'cltbld', 17:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:16:59 INFO - 'XPC_FLAGS': '0x0', 17:16:59 INFO - 'XPC_SERVICE_NAME': '0', 17:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:00 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 17:17:00 INFO - Cleaning up... 17:17:00 INFO - Return code: 0 17:17:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:00 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 0x1021f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44b565de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021159f0>, '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 0x101e75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021098c8>, '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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 17:17:00 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 17:17:00 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 17:17:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9WOJVQ63p/Render', 17:17:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:00 INFO - 'HOME': '/Users/cltbld', 17:17:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:00 INFO - 'LOGNAME': 'cltbld', 17:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:00 INFO - 'MOZ_NO_REMOTE': '1', 17:17:00 INFO - 'NO_EM_RESTART': '1', 17:17:00 INFO - 'PAGER': '/bin/cat', 17:17:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:00 INFO - 'PWD': '/builds/slave/test', 17:17:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:00 INFO - 'SHELL': '/bin/bash', 17:17:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TbrtN6QL5U/Listeners', 17:17:00 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 17:17:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:00 INFO - 'USER': 'cltbld', 17:17:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:00 INFO - 'XPC_FLAGS': '0x0', 17:17:00 INFO - 'XPC_SERVICE_NAME': '0', 17:17:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:00 INFO - Downloading/unpacking psutil>=0.7.1 17:17:00 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 17:17:00 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 17:17:00 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 17:17:00 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 17:17:00 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 17:17:00 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 17:17:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:17:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:03 INFO - Installing collected packages: psutil 17:17:03 INFO - Running setup.py install for psutil 17:17:03 INFO - building 'psutil._psutil_osx' extension 17:17:03 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 17:17:03 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 17:17:03 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 17:17:03 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 17:17:03 INFO - building 'psutil._psutil_posix' extension 17:17:03 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 17:17:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:17:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:17:03 INFO - ^ 17:17:03 INFO - 1 warning generated. 17:17:03 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 17:17:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:04 INFO - Successfully installed psutil 17:17:04 INFO - Cleaning up... 17:17:04 INFO - Return code: 0 17:17:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:04 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 0x1021f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44b565de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021159f0>, '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 0x101e75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021098c8>, '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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 17:17:04 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 17:17:04 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 17:17:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9WOJVQ63p/Render', 17:17:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:04 INFO - 'HOME': '/Users/cltbld', 17:17:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:04 INFO - 'LOGNAME': 'cltbld', 17:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:04 INFO - 'MOZ_NO_REMOTE': '1', 17:17:04 INFO - 'NO_EM_RESTART': '1', 17:17:04 INFO - 'PAGER': '/bin/cat', 17:17:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:04 INFO - 'PWD': '/builds/slave/test', 17:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:04 INFO - 'SHELL': '/bin/bash', 17:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TbrtN6QL5U/Listeners', 17:17:04 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 17:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:04 INFO - 'USER': 'cltbld', 17:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:04 INFO - 'XPC_FLAGS': '0x0', 17:17:04 INFO - 'XPC_SERVICE_NAME': '0', 17:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:17:04 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 17:17:04 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 17:17:04 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 17:17:04 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 17:17:04 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 17:17:04 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 17:17:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:17:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:17:07 INFO - Installing collected packages: mozsystemmonitor 17:17:07 INFO - Running setup.py install for mozsystemmonitor 17:17:07 INFO - Successfully installed mozsystemmonitor 17:17:07 INFO - Cleaning up... 17:17:07 INFO - Return code: 0 17:17:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:07 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 0x1021f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44b565de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021159f0>, '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 0x101e75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021098c8>, '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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 17:17:07 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 17:17:07 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 17:17:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9WOJVQ63p/Render', 17:17:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:07 INFO - 'HOME': '/Users/cltbld', 17:17:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:07 INFO - 'LOGNAME': 'cltbld', 17:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:07 INFO - 'MOZ_NO_REMOTE': '1', 17:17:07 INFO - 'NO_EM_RESTART': '1', 17:17:07 INFO - 'PAGER': '/bin/cat', 17:17:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:07 INFO - 'PWD': '/builds/slave/test', 17:17:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:07 INFO - 'SHELL': '/bin/bash', 17:17:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TbrtN6QL5U/Listeners', 17:17:07 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 17:17:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:07 INFO - 'USER': 'cltbld', 17:17:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:07 INFO - 'XPC_FLAGS': '0x0', 17:17:07 INFO - 'XPC_SERVICE_NAME': '0', 17:17:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:07 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 17:17:07 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 17:17:07 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 17:17:07 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 17:17:07 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 17:17:07 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 17:17:10 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17:10 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 17:17:10 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 17:17:10 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 17:17:10 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 17:17:10 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 17:17:10 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 17:17:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:17:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17:11 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 17:17:11 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 17:17:11 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 17:17:11 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 17:17:11 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 17:17:11 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 17:17:11 INFO - Downloading docopt-0.6.1.tar.gz 17:17:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:11 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:11 INFO - Running setup.py install for blobuploader 17:17:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:11 INFO - Running setup.py install for requests 17:17:12 INFO - Running setup.py install for docopt 17:17:12 INFO - Successfully installed blobuploader requests docopt 17:17:12 INFO - Cleaning up... 17:17:12 INFO - Return code: 0 17:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:12 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 0x1021f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44b565de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021159f0>, '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 0x101e75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021098c8>, '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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 17:17:12 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 17:17:12 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 17:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9WOJVQ63p/Render', 17:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:12 INFO - 'HOME': '/Users/cltbld', 17:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:12 INFO - 'LOGNAME': 'cltbld', 17:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:12 INFO - 'MOZ_NO_REMOTE': '1', 17:17:12 INFO - 'NO_EM_RESTART': '1', 17:17:12 INFO - 'PAGER': '/bin/cat', 17:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:12 INFO - 'PWD': '/builds/slave/test', 17:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:12 INFO - 'SHELL': '/bin/bash', 17:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TbrtN6QL5U/Listeners', 17:17:12 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 17:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:12 INFO - 'USER': 'cltbld', 17:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:12 INFO - 'XPC_FLAGS': '0x0', 17:17:12 INFO - 'XPC_SERVICE_NAME': '0', 17:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:12 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-bpU3bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:13 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-Pm8m2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:13 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-549J_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:13 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-YiTqmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:13 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-hTLidA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:13 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-YL1Ash-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:13 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-YB0fzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:13 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-drH5XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:13 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-5VLrSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:14 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-waAYdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:14 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-ZRXmQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:14 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-TmKNIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:14 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-LwSrvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:14 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-bgc90m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:14 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-kPUDxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:14 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-61oPHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:14 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-fb0je9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:15 INFO - Running setup.py install for manifestparser 17:17:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:15 INFO - Running setup.py install for mozcrash 17:17:15 INFO - Running setup.py install for mozdebug 17:17:15 INFO - Running setup.py install for mozdevice 17:17:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:15 INFO - Running setup.py install for mozfile 17:17:15 INFO - Running setup.py install for mozhttpd 17:17:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozinfo 17:17:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozInstall 17:17:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for mozleak 17:17:16 INFO - Running setup.py install for mozlog 17:17:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:16 INFO - Running setup.py install for moznetwork 17:17:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Running setup.py install for mozprocess 17:17:17 INFO - Running setup.py install for mozprofile 17:17:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Running setup.py install for mozrunner 17:17:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:17 INFO - Running setup.py install for mozscreenshot 17:17:17 INFO - Running setup.py install for moztest 17:17:18 INFO - Running setup.py install for mozversion 17:17:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:18 INFO - Cleaning up... 17:17:18 INFO - Return code: 0 17:17:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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', '-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 0x1021f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44b565de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021159f0>, '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 0x101e75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021098c8>, '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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 17:17:18 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 17:17:18 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 17:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9WOJVQ63p/Render', 17:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:18 INFO - 'HOME': '/Users/cltbld', 17:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:18 INFO - 'LOGNAME': 'cltbld', 17:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:18 INFO - 'MOZ_NO_REMOTE': '1', 17:17:18 INFO - 'NO_EM_RESTART': '1', 17:17:18 INFO - 'PAGER': '/bin/cat', 17:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:18 INFO - 'PWD': '/builds/slave/test', 17:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:18 INFO - 'SHELL': '/bin/bash', 17:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TbrtN6QL5U/Listeners', 17:17:18 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 17:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:18 INFO - 'USER': 'cltbld', 17:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:18 INFO - 'XPC_FLAGS': '0x0', 17:17:18 INFO - 'XPC_SERVICE_NAME': '0', 17:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:18 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-8Q9d43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:18 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-wYbGT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:18 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-iP1Axg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:18 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)) 17:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:18 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-7B66Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:19 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-lwjytW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:19 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-IpMkKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:19 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-ovkpGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:19 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-Ew8IKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:19 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-f2ncTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:19 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-1f5cY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:19 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-S0iRhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:19 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)) 17:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:19 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-W_9FJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:20 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)) 17:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:20 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-z0Qaey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:20 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)) 17:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:20 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-pdPXT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:20 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)) 17:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:20 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-nCANH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:20 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)) 17:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:20 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-aVM56F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:20 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)) 17:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:20 INFO - Running setup.py (path:/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/pip-rbDbGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:20 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)) 17:17:20 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)) 17:17:20 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)) 17:17:20 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)) 17:17:20 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)) 17:17:20 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)) 17:17:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:20 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 17:17:20 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 17:17:20 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 17:17:20 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 17:17:20 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 17:17:20 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 17:17:23 INFO - Downloading blessings-1.5.1.tar.gz 17:17:23 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 17:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:23 INFO - Installing collected packages: blessings 17:17:23 INFO - Running setup.py install for blessings 17:17:23 INFO - Successfully installed blessings 17:17:23 INFO - Cleaning up... 17:17:23 INFO - Return code: 0 17:17:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:24 INFO - Reading from file tmpfile_stdout 17:17:24 INFO - Current package versions: 17:17:24 INFO - blessings == 1.5.1 17:17:24 INFO - blobuploader == 1.2.4 17:17:24 INFO - docopt == 0.6.1 17:17:24 INFO - manifestparser == 1.1 17:17:24 INFO - mozInstall == 1.12 17:17:24 INFO - mozcrash == 0.16 17:17:24 INFO - mozdebug == 0.1 17:17:24 INFO - mozdevice == 0.47 17:17:24 INFO - mozfile == 1.2 17:17:24 INFO - mozhttpd == 0.7 17:17:24 INFO - mozinfo == 0.9 17:17:24 INFO - mozleak == 0.1 17:17:24 INFO - mozlog == 3.0 17:17:24 INFO - moznetwork == 0.27 17:17:24 INFO - mozprocess == 0.22 17:17:24 INFO - mozprofile == 0.27 17:17:24 INFO - mozrunner == 6.11 17:17:24 INFO - mozscreenshot == 0.1 17:17:24 INFO - mozsystemmonitor == 0.0 17:17:24 INFO - moztest == 0.7 17:17:24 INFO - mozversion == 1.4 17:17:24 INFO - psutil == 3.1.1 17:17:24 INFO - requests == 1.2.3 17:17:24 INFO - wsgiref == 0.1.2 17:17:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x1021f2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cf228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff44b565de0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021159f0>, '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 0x101e75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021098c8>, '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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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 17:17:24 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 17:17:24 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 17:17:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9WOJVQ63p/Render', 17:17:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:24 INFO - 'HOME': '/Users/cltbld', 17:17:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:24 INFO - 'LOGNAME': 'cltbld', 17:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:24 INFO - 'MOZ_NO_REMOTE': '1', 17:17:24 INFO - 'NO_EM_RESTART': '1', 17:17:24 INFO - 'PAGER': '/bin/cat', 17:17:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:24 INFO - 'PWD': '/builds/slave/test', 17:17:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:24 INFO - 'SHELL': '/bin/bash', 17:17:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TbrtN6QL5U/Listeners', 17:17:24 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 17:17:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:24 INFO - 'USER': 'cltbld', 17:17:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:24 INFO - 'XPC_FLAGS': '0x0', 17:17:24 INFO - 'XPC_SERVICE_NAME': '0', 17:17:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:24 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)) 17:17:24 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)) 17:17:24 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)) 17:17:24 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)) 17:17:24 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)) 17:17:24 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)) 17:17:24 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)) 17:17:24 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)) 17:17:24 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)) 17:17:24 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)) 17:17:24 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)) 17:17:24 INFO - Cleaning up... 17:17:24 INFO - Return code: 0 17:17:24 INFO - Running post-action listener: _resource_record_post_action 17:17:24 INFO - Running post-action listener: _start_resource_monitoring 17:17:24 INFO - Starting resource monitoring. 17:17:24 INFO - ##### 17:17:24 INFO - ##### Running install step. 17:17:24 INFO - ##### 17:17:24 INFO - Running pre-action listener: _resource_record_pre_action 17:17:24 INFO - Running main action method: install 17:17:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:24 INFO - Reading from file tmpfile_stdout 17:17:24 INFO - Detecting whether we're running mozinstall >=1.0... 17:17:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:17:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:17:24 INFO - Reading from file tmpfile_stdout 17:17:24 INFO - Output received: 17:17:24 INFO - Usage: mozinstall [options] installer 17:17:24 INFO - Options: 17:17:24 INFO - -h, --help show this help message and exit 17:17:24 INFO - -d DEST, --destination=DEST 17:17:24 INFO - Directory to install application into. [default: 17:17:24 INFO - "/builds/slave/test"] 17:17:24 INFO - --app=APP Application being installed. [default: firefox] 17:17:24 INFO - mkdir: /builds/slave/test/build/application 17:17:24 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'] 17:17:24 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 17:18:03 INFO - Reading from file tmpfile_stdout 17:18:03 INFO - Output received: 17:18:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:18:03 INFO - Running post-action listener: _resource_record_post_action 17:18:03 INFO - ##### 17:18:03 INFO - ##### Running run-tests step. 17:18:03 INFO - ##### 17:18:03 INFO - Running pre-action listener: _resource_record_pre_action 17:18:03 INFO - Running main action method: run_tests 17:18:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:18:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:18:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:18:03 INFO - 2015-11-16 17:18:03.947 screenresolution[1943:20905] starting screenresolution argv=screenresolution get 17:18:03 INFO - 2015-11-16 17:18:03.950 screenresolution[1943:20905] Display 0: 1600x1200x32@60 17:18:03 INFO - 2015-11-16 17:18:03.957 screenresolution[1944:20908] starting screenresolution argv=screenresolution list 17:18:03 INFO - Available Modes on Display 0 17:18:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:18:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:18:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:18:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:18:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:18:04 INFO - Intel HD Graphics 3000: 17:18:04 INFO - Chipset Model: Intel HD Graphics 3000 17:18:04 INFO - Type: GPU 17:18:04 INFO - Bus: Built-In 17:18:04 INFO - VRAM (Total): 512 MB 17:18:04 INFO - VRAM (Dynamic, Max): 10 17:18:04 INFO - Vendor: Intel (0x8086) 17:18:04 INFO - Device ID: 0x0116 17:18:04 INFO - Revision ID: 0x0009 17:18:04 INFO - Displays: 17:18:04 INFO - Display: 17:18:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:18:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:18:04 INFO - Display Serial Number: 1600x1200 60 17:18:04 INFO - Main Display: Yes 17:18:04 INFO - Mirror: Off 17:18:04 INFO - Online: Yes 17:18:04 INFO - Rotation: Supported 17:18:04 INFO - Return code: 0 17:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:04 INFO - Python 2.7.3 17:18:04 INFO - Return code: 0 17:18:04 INFO - grabbing minidump binary from tooltool 17:18: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')]} 17:18:04 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 0x1021159f0>, '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 0x101e75db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021098c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:04 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 17:18:04 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 17:18:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:04 INFO - Return code: 0 17:18:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:18:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:18:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:04 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/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0026', '--webServer', 'localhost'] in /builds/slave/test/build 17:18:04 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/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0026 --webServer localhost 17:18:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9WOJVQ63p/Render', 17:18:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:04 INFO - 'HOME': '/Users/cltbld', 17:18:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:04 INFO - 'LOGNAME': 'cltbld', 17:18:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:04 INFO - 'MOZ_NO_REMOTE': '1', 17:18:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:04 INFO - 'NO_EM_RESTART': '1', 17:18:04 INFO - 'PAGER': '/bin/cat', 17:18:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:04 INFO - 'PWD': '/builds/slave/test', 17:18:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:04 INFO - 'SHELL': '/bin/bash', 17:18:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TbrtN6QL5U/Listeners', 17:18:04 INFO - 'TMPDIR': '/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/', 17:18:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:04 INFO - 'USER': 'cltbld', 17:18:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:04 INFO - 'XPC_FLAGS': '0x0', 17:18:04 INFO - 'XPC_SERVICE_NAME': '0', 17:18:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 17:18:04 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/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0026', '--webServer', 'localhost'] with output_timeout 3600 17:18:04 INFO - mozversion INFO | application_buildid: 20151116145334 17:18:04 INFO - mozversion INFO | application_changeset: 3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33 17:18:04 INFO - mozversion INFO | application_display_name: Nightly 17:18:04 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:04 INFO - mozversion INFO | application_name: Firefox 17:18:04 INFO - mozversion INFO | application_remotingname: firefox 17:18:04 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:18:04 INFO - mozversion INFO | application_vendor: Mozilla 17:18:04 INFO - mozversion INFO | application_version: 45.0a1 17:18:04 INFO - mozversion INFO | platform_buildid: 20151116145334 17:18:04 INFO - mozversion INFO | platform_changeset: 3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33 17:18:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:18:04 INFO - mozversion INFO | platform_version: 45.0a1 17:18:04 INFO - 2015-11-16 17:18:04,594 DEBUG : using testdate: 1447723084 17:18:04 INFO - 2015-11-16 17:18:04,594 DEBUG : actual date: 1447723084 17:18:04 INFO - 2015-11-16 17:18:04,603 INFO : starting webserver on 'localhost:50757' 17:18:04 INFO - 2015-11-16 17:18:04,604 INFO : Starting test suite t-yosemite-r5-0026 17:18:04 INFO - 2015-11-16 17:18:04,605 INFO : Starting test dromaeo_css 17:18:04 INFO - 2015-11-16 17:18:04,605 DEBUG : operating with platform_type : mac_ 17:18:04 INFO - 2015-11-16 17:18:04,605 INFO : Initialising browser for dromaeo_css test... 17:18:04 INFO - 2015-11-16 17:18:04,639 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpfx5nvb/profile http://localhost:50757/getInfo.html 17:18:07 INFO - 2015-11-16 17:18:07,635 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:18:07 INFO - 2015-11-16 17:18:07,635 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:18:07 INFO - 2015-11-16 17:18:07,635 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:18:07 INFO - 2015-11-16 17:18:07,635 DEBUG : BROWSER_OUTPUT: __metrics 17:18:07 INFO - 2015-11-16 17:18:07,651 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:18:08 INFO - 2015-11-16 17:18:08,379 INFO : Browser initialized. 17:18:08 INFO - 2015-11-16 17:18:08,379 INFO : Running cycle 1/1 for dromaeo_css test... 17:18:08 INFO - 2015-11-16 17:18:08,379 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpfx5nvb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:18:20 INFO - 2015-11-16 17:18:20,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 230047744 17:18:20 INFO - 2015-11-16 17:18:20,465 DEBUG : BROWSER_OUTPUT: 17:19:12 INFO - 2015-11-16 17:19:12,367 DEBUG : BROWSER_OUTPUT: 1447723152363 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] 17:21:22 INFO - 2015-11-16 17:21:22,528 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50757/tests/dromaeo/cssquery-ext.html) 17:21:23 INFO - 2015-11-16 17:21:23,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 343384064 17:21:23 INFO - 2015-11-16 17:21:23,727 DEBUG : BROWSER_OUTPUT: 17:24:26 INFO - 2015-11-16 17:24:26,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-ext.html (next: http://localhost:50757/tests/dromaeo/cssquery-jquery.html) 17:24:27 INFO - 2015-11-16 17:24:27,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 357679104 17:24:27 INFO - 2015-11-16 17:24:27,264 DEBUG : BROWSER_OUTPUT: 17:27:29 INFO - 2015-11-16 17:27:29,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50757/tests/dromaeo/cssquery-mootools.html) 17:27:30 INFO - 2015-11-16 17:27:30,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 336031744 17:27:30 INFO - 2015-11-16 17:27:30,008 DEBUG : BROWSER_OUTPUT: 17:30:32 INFO - 2015-11-16 17:30:32,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50757/tests/dromaeo/cssquery-prototype.html) 17:30:32 INFO - 2015-11-16 17:30:32,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 321036288 17:30:32 INFO - 2015-11-16 17:30:32,710 DEBUG : BROWSER_OUTPUT: 17:33:36 INFO - 2015-11-16 17:33:36,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50757/tests/dromaeo/cssquery-yui.html) 17:33:36 INFO - 2015-11-16 17:33:36,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 320733184 17:33:36 INFO - 2015-11-16 17:33:36,763 DEBUG : BROWSER_OUTPUT: 17:36:39 INFO - 2015-11-16 17:36:39,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/dromaeo/cssquery-yui.html (next: http://localhost:50757/tests/dromaeo/cssquery-dojo.html) 17:36:39 INFO - 2015-11-16 17:36:39,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 370221056 17:36:39 INFO - 2015-11-16 17:36:39,693 DEBUG : BROWSER_OUTPUT: 17:36:39 INFO - 2015-11-16 17:36:39,695 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:36:39 INFO - 2015-11-16 17:36:39,695 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:36:39 INFO - 2015-11-16 17:36:39,695 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:36:39 INFO - 2015-11-16 17:36:39,695 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:36:39 INFO - 2015-11-16 17:36:39,699 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2938.3829395826874;2940.2796314902866;2946.1014390610853;2987.447322245385;3126.2497000719827;4693.342931989516;4698.600618947389;4792.6405519586;4892.828750993716;4900.436449808273;4772.832950846712;4795.928061079087;4813.518648135194;4913.287573301878;4956.132676781558;4457.531959144292;4473.932891006638;4478.619317358012;4577.748223847687;4596.747178905159;4554.795034223452;4580.748058856761;4583;4622.075584883037;4640.164770341337;4303.763293018883;4351.782410879443;4441.689081764278;4468.620167285784;4591.150637132125;4498.257787465064;4529.139463501924;4548.658850586219;4571.6114130298965;4591.104734576759;4484.8878778030485;4501.504834468205;4509.120721459317;4549.499555048942;4562.634989200856;4714.387129673155;4776.044791041805;4795.112904112715;4809.23052311632;4849.490803465621;5098.566621837148;5137.845864624067;5138.871528211825;5145.485451454824;5146.099432599281;5150.922736158961;5160.122779127557;5215.791368345262;5257.947420525784;5259.921101183485;4714.104320179189;4764.071006153836;4815.927761083586;4828.106800241966;4848.272759086095;5232.110541208004;5352.759125839347;5394.62237643369;5426.403095659474;5455.454454554513;5119.1553393690365;5193.350831146106;5204.271402003723;5208.635395522353;5232.189010703347;5211.348581427322;5254.3169387979315;5259.8422047338645;5264.289320941624;5347.064263753905;5161.612879034087;5224.738763061831;5229.633925625246;5262.052830490472;5263.157894736823;5186.351706036746;5235.319408476874;5235.345581802275;5266.3943646480375;5301.125314323171;3945.447637330776;3988.222296652125;4083.4283200351974;4106.2198182345255;4115.814788334532;3617.4212126059706;3621.8370173342264;3625.41993281079;3679.7424180307657;3699.0197597636648;4820.30105634681;4825.638077144228;4831.396075490564;4851.175300198975;4896.436909755353;5065.39215294167;5191.8182863599595;5195.584353251731;5261.973690131525;5385.676859388449;4937.086638971802;4937.925931111036;4947.82682606107;4969.229769385751;5009.373828271466;4640.466346370143;4679.64902632304;4692.601128904013;4694.1550520905885;4750.714957102585;5224.50367215114;5316.680999140064;5381.085215513293;5382.7308634567335;5461.098918678374;5270.156774915995;5294.232336311136;5337.679739215504;5337.6797392156595;5338.786448542171;5393.568514518751;5431.34823821144;5440.347158341025;5443.863903402446;5447.470817120648;5142.8971420572125;5163.380394352702;5214.113600687816;5254.15933450646;5274.762635681327;5305;5307.548858347083;5317.229001794795;5345.492178243061;5418.539424148991;5174;5207.3490813648295;5207.401148867929;5218.8956220876125;5270.288511050959;5013.273075403973;5146.25379319989;5158.638895277295;5167.870803229799;5201.895962080813;5017.698938063728;5028.899422011466;5052.292679024866;5074.391073071255;5132.050570644443;5146.356705411824;5156.484351564964;5179.1454410021925;5192.299039629753;5201;4971.676841005323;5088.898222035613;5093.1341671915125;5112.3865136183895;5120.564751996122 17:36:39 INFO - 2015-11-16 17:36:39,699 DEBUG : BROWSER_OUTPUT: |1;ext.html;508.3112382721412;509.20055512844823;520.1755217979502;520.8697825543614;534.871630808606;27546.17361479154;28882.566761498594;35557;35856.2828743425;35930;37831.62168378315;38274.4258836117;38398;38438.23123537528;38613;7354.264573542657;8251.876221856677;8352.498850068985;8433.915660843406;8451.74644760655;7278.636068196595;9981.950090249538;10118.494075296243;10141.543630536644;10143.340682855627;9816.6073357066;9888.604455821758;9904.603815847357;9927.602895884156;9931;7554.131274903347;7705.537667739954;9862.45756483393;9898.059684329977;9928.156106730901;9699.321047526675;9833.557489912899;9862.260330475172;9864.753381165528;9894.257930655158;35256.11859703528;35440.645593543995;35655.82172089149;35739.4639080414;35760.64239357625;2640.1287575100173;2744.8266936138093;2992.7905046646742;3073.3085055862252;3087.2744904947544;24483.632745508654;24598.262052138463;24863;25003.249902502954;25760.613590796154;2074.647309957311;2129.2228336657163;2148.6828723552703;2155.5257843274453;2281.0761641535205;231939;232306;232366;232505;232894;48403;49719;49826.013918887125;51507.7424612882;52958;48194.27708584304;48338.27492587614;48506.27240591394;48519;48585;12730.10889237763;12842.550510732079;12873.22760634365;12914.354282285849;12937.223766574036;9713.07725766051;9741.512924353754;9747.074027967332;9778.41329520231;9883.357581757164;16512.669746605;16840.66318673644;17013.31946722142;17035.659286814196;17114.743278850827;7622.771316860503;7850.528968261922;7887.290143887078;7899.565523896241;7956.124826269106;842.8609279468819;916.2074805293373;932.3520153493257;1012.6607586458472;1038.7403149212696;24790.628140577905;25094.498110037697;25537.36156596063;25608;25705.357366065626;875.4003507597316;924.2929159193222;946.2240962410757;1039.1946241662772;1051.5741124844296;12494.75010499785;12674.683132921751;12687.746245075046;13353.46586136563;13791.241481718402;287588;290905;291076;291079;292548;47763.522364775905;48123.75938120357;48243.5175648239;48344.75827620839;48370.758146209046;1238.3374894431436;1262.9431675574438;1266.4364357860848;1275.4451813461174;1277.5273148934953;24732.752672473045;25443.87278063672;25658.743412565636;25725.871370643028;25741.871290644176;42051.1589768209;42285.36571951485;42483.36274955816;42516.5748342525;42527.3620895693;259804;262502;263071;263312;263506;23617.866873297447;23879.283621491384;27780.583291250245;27789.30526736767;27797.583036254877;34569;34586.48120278148;34772.13069673177;34779.130521737156;35019.64980350164;29908;30301.393972119993;30878.53682194724;31089.53365699471;32271;24401;28959.710402896544;29848.701512984593;30864.382712346076;31080.22299442532;26661.600075999264;26835;30866.53700194454;31719.682803171672;31854.203644908135;26896.32759181036;27792.72207277901;28032.439351212455;28121.578176326962;28137.44226787666;21152;21165.25921592737;21323.68014479753;21350;21544.676829847253 17:36:39 INFO - 2015-11-16 17:36:39,702 DEBUG : BROWSER_OUTPUT: |2;jquery.html;297.49871466578804;303.2101375915739;304.91919641295044;306.8220432149354;310.4334589374392;12887.162334448254;13331.733365332688;15537.53387398377;15567.84432155678;16095.114768687732;10450.477476126182;10656.680299591024;10682.51928663212;13094.279814610192;15586.142762148078;3927.646511813943;3960.0297927007923;4022.919541609166;4035.556088830226;4045.757254564721;3029.8939537116207;3120.6723294054136;3920.529536455615;4000;4236.089240813225;4287.871363859089;4288.485381754178;4317.352397140438;4317.568243175689;4330.631896288819;4217.7891105444605;4221.936670949938;4280.058387154821;4306.181825453185;4318.9784051079705;3644.2164934538937;3659.3413185626578;3661.139632186434;3683.226522430293;3684.355237833395;11835.171537992344;12011.219270747373;12207.328596927166;12265.202761820543;12295;1568.5529624057203;1577.495201535509;1630.7879975603096;1648.7609296651917;1677.2284749015469;8476.449030812977;8557.400981931267;8749;8757;8860.8670869937;1298.681822953373;1318.4792007157216;1337.6722702937745;1389.7359501694646;1408.7319415740649;52226.21660675093;54095.45904540983;54313.72843135799;54769.72615136939;54788.72605636986;5640.125780504029;5789.478946894799;5818.854528636733;5833.095870140135;5942.257217847769;6530.216374035146;6725;6757.662116894136;6777.796666100025;6794.626295553792;4727.669063165614;4740.597049250783;4764.499727528629;4779.044191161782;4783.5933945614315;4867.099586576494;4876.926846097312;4936;5028.120078986163;5030.597552195815;2621.5936529837904;2671.7061123276426;2682.771964383049;2705.6076868853906;2715.4840580289683;928.4661319741176;928.9814203716023;943.6036864516919;960.2462067277154;989.2185173712686;359.3926264612796;383.70646455461593;415.3479037910512;416.1780483545035;435.8801329634376;9925.404475731479;10357.119644830274;10493.265471416928;10524;10635.255532112833;361.41631265506544;396.2352659367391;405.9309917314064;426.2157629960887;428.74918172869224;5522.199281104217;5548;5810.564207684441;5890.263717035371;5932.940670593239;503229;504634;519382;522564;523491;62445;63166.36833631697;63309;64535.67732161309;64710.676446617465;456.67576021025445;461.8452818305905;465.3485120830864;467.5675000624409;467.9766011699401;9936.304458687822;9938.204943604349;10074.395536267848;10117.190624749855;10118.645847395306;31610.36779264356;31687.683123168474;32122.67877321197;32136;32384.190395240308;42191.57808421877;42213.36679949742;42844.35733464063;42850;43396;5578;5653.802116925888;5667.1782591524825;5669.206311116364;5697.914531282117;10329.535170917177;10331.225158113322;10565.63020294286;10679.626213082505;10688.732781680521;8957.641694332153;9270.675526356545;9303.069693030913;9355;9370.203532699798;8657.696980605648;8947.59735811903;8981.640734370552;9000.099990000948;9006.954965225132;7815;9115.179633832988;9156.816863662823;9434.103760142776;9442.339036267671;5059.367579052619;5067.87330316745;5327.440618734977;5480.479354461319;5488.341399032141;8895.154960278764;9051.728448146567;9150.176484116462;9161.725148245563;9165.083491651048 17:36:39 INFO - 2015-11-16 17:36:39,702 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1176.0591526778576;1287.7617640736462;1324.8079028540863;1371.5473893615108;1683.2509533257698;6651.4678825693945;6814.5911245325315;6918.308169183079;6934.861302773941;6976.860462790741;7177.712891484334;7224.422046236302;7245.963770181142;7269.236730143325;7316;2036.0430597619131;2045.447729113146;2050.2106688924796;2052.9897350513224;2057.660486019805;2071.2957594417894;2091.299414696071;2094;2107.4942013916702;2124.8618839775363;2012.8792272463627;2044.7239622650975;2063.515073957619;2066.442060643625;2066.741657292838;2014.1641218894142;2016.1632922337212;2036.0125339210472;2040.1125510403022;2045.3148195354574;2042.714020037196;2055.9794402056086;2064.7315848939543;2081.5420607466335;2087.885166315852;6460.612363258219;7186.856262874766;7205.35151836332;7214.74748383804;7229.746958856467;4106.897327566835;4290.292101803198;4456.6880318377725;4463.977680111611;4465.508794032654;2571.2800415883585;2604.6744156980376;2650.681918169813;2653.8938442462277;2671.906483273076;818.3412353055787;825.6862392290951;1446.6889618731918;1454.4036944852664;1515.1893736850732;9698.563564639608;9797.118259356692;9802.509874506246;9804.411735295906;9834.606615735362;3962.841486340572;3979.323515002399;4045.6156665117355;4050.4734384529825;4060.045889216032;8016.639251233709;8071.23323284287;8072;8078.959605201936;8092.352611791042;4554;4571.771411429415;4574.4739354973935;4575.565321294472;4578.88552786183;4173.1862286854375;4175.269327867672;4205.3902184183125;4212.347086201644;4218.557051509609;3074.723274905269;3119.3293441909645;3123.7188653021335;3149.2914094328594;3153.936921261608;968.651285537206;981.6760469045198;985.4776968206719;997.042838874674;997.5560875410373;960.7790208252142;994.3834822410151;1161.6573110932295;1175.5297880847559;1175.6766889105393;6873.48448866327;6889.0355350251;6947.617881016491;6948.791536253921;6955.513114081966;1064.834950582661;1119.652907598647;1142.5601143559788;1158.901493373056;1162.3723189477757;5143.5113664201845;5373.194020896819;5453.972730136324;5467.562594992471;5475.753591088411;8130.105688374274;8352.290055345242;8654.177853103945;8827;8862.689805856764;8284.751457456287;8624.568771561397;8699.347548933856;8707.042225355206;8717.433366831136;6629.569078009914;6683.331666833278;6697.7655782047395;6742.42689371409;6752.797416077526;6592.43964263043;6675.499337549801;6686.0973768540625;6714.4292735116105;6717.764878229238;7475.962620186864;7487.775366739006;7515.210902855121;7608.80977975555;7633.389328853789;7518.849623007619;7695.461317707706;7715.537067775951;7782.805429864298;7790.493617914817;6030;6073.817785466443;6085.269767627913;6105.877882442237;6153.784617538365;6825.1127353443735;6906.171259448898;6967.407770339578;6968.163820341389;6991.755288564876;6296.968515157395;6393.552451328548;6547.214334279917;6621.768238111643;6640.269570347355;6399.904001439889;6417.903731444126;6434.292227855026;6475.222973243241;6504.317046710027;6548.214214294315;6567.146270984741;6567.408933196035;6600.570962887397;6613.900791488035;5670.234518340137;5841.737121829443;5860.062390017577;5866.6480011199465;5893.734781934738;5825.592208545361;5853.531717462508;5873.706314684163;5901.911471327848;5914.585978981602 17:36:39 INFO - 2015-11-16 17:36:39,706 DEBUG : BROWSER_OUTPUT: |4;prototype.html;280.80764676196804;285.91565488180987;292.88577454792636;294.2320543381775;298.70875896001417;5658.943410565893;5680.545556355492;5707.857303567413;5752.223449834271;5819.4471525205145;5711.143328500727;5778.162166485857;5798.275215598051;5816.680082595455;5849.9707501462535;4357.825686972526;4357.847475338363;4359.433273674418;4365.497967733703;4370.38814565961;4148.668106551469;4257.084726783741;4257.8296868125235;4266.7439953602725;4351.934720979188;4263.360495925605;4282.100758840632;4292.18448494785;4296.441462609856;4311.784410779464;4131.235721391552;4293.785310734466;4299.935500967488;4305.526392096866;4308.31067029277;3559.18138828071;3587.0852932502307;3628.256207477461;3628.872989445357;3648.2885837261742;5509.614326997112;5530.087535556629;5534.916976245359;5554.389017208104;5574.58190635704;4854.320395144682;4864.294677271776;4870.391201099863;4876.731779752112;4884.902301953976;5777.88444231113;5995.070764031582;6003.549733769941;6006.609570377911;6007.279126504804;3974.423708562242;3995.161016186575;3999.0402303447254;4003.259397011533;4008.599140085997;6222.782202622887;6329.2721337045905;6335.04974253861;6342.80971570849;6344.175257216532;4020.2160578686876;4027.275090483741;4035.233305671913;4039.434479172918;4057.0263136846943;3965.9603403966166;4065.0243941453837;4076.796160192038;4085.8569950051606;4090.550039495653;4833.685810422311;4841.95158048422;4844.394450693663;4852.398708426211;4856.854294371175;6027.095935609606;6032.034874420072;6032.426919442646;6036.275646922398;6047.244094488189;1383.9100458470168;1446.5515690136092;1447.4282658349894;1450.8549145085408;1451.8620731030535;916.9908300917039;924.3806649544821;929.1544694328264;935.4808081514689;948.3977674176809;5750.539956803445;5774.682392468455;5789.565782566325;5802.303723553201;5823.679697616587;6274.717637706223;6282;6288.591241569284;6294.653794041372;6319.462845658079;5732.942670573324;5754.136879468029;5761.9135712964335;5784.59507834456;5786.132080188006;3276.819774912355;3310.8344582770765;3346.6151392590164;3363.24327026422;3413.6586341365664;6359.427651511386;6514.57655252407;6556.442702370352;6569.178852643419;6574.539782215199;6526.771562995367;6532.412082912466;6534.934650653528;6538.509611779135;6545.705443255065;6329.968350158312;6542.476601871839;6561.671916404256;6567.113439685677;6572.638504882278;6340.239171299289;6351.555391122577;6355.88771964895;6359;6367.458766004941;6199.752009919553;6212.192414986023;6235.75056997715;6240.906386404116;6249.96875015622;6295.401936815995;6501.934980650322;6518.641474718936;6552.934470655423;6561.245456772533;4054.1283624020975;4092.3656833190903;4093.263212621757;4096.508418989741;4110.712250142461;6283.151774510383;6307.148534947723;6333.303336633059;6342.90485642725;6344;6137.723802428991;6158.784442544489;6158.907616385847;6174.66039367839;6194.38056194377;5856.9121463178935;6004.579679422399;6029.366916473882;6037.69811509414;6119.785807496716;5955.612885162624;5982.730777115127;5998.70006499682;5999.52003839683;6001.06983417571;6093;6100.389961003864;6115.327313995368;6117.602355846856;6124;5858.736356863866;5931.1992880960515;6024.33732289439;6034.064719968412;6048.153258543895 17:36:39 INFO - 2015-11-16 17:36:39,707 DEBUG : BROWSER_OUTPUT: |5;yui.html;665.693780860804;667.3060017581715;675.8276639456938;679.5175425447932;694.600604652325;12345.938270308647;12376.752464950696;12631.178973366736;12638.557650482235;12665.873341266608;11770.352630605314;11787.233829801078;11806.822897656542;11832.7633447331;11868.406579671004;644.0564572900699;659.3340725866861;797.2107613462674;811.5820352518458;818.9344852411823;797.366093955307;799.3205775091184;809.7327881798992;811.4684881402661;813.2274339377615;822.8436597046542;823.9093699693029;830.3025458614762;835.064727505195;835.3651225068961;655.8589903170817;670.0485310858593;821.4701517521195;829.1708291708292;843.228445971941;623.7847942459844;625.2809269340249;627.42903957399;628.7736414890636;633.8732253549263;12262.570810021607;12418.81371779424;12477.438515266744;12478.251304921734;12490.43793029316;10049.145822605087;10155.492225388702;10443;10711.464426778708;10778.838317425245;8390.538520381377;8416.452930559493;8519.557254498815;8577.699780507652;8671.56642167889;3016.8642411091555;3040.665526792051;3056.0984509569507;3061.800982936102;3070.125014370916;44325;44456.77771611154;44646.33030504545;45078.77460612676;45299.09401811945;8180.754577362689;8249;8256.25693687571;8290.709825156091;8308.459950103224;17760.37838675666;17778;17792.55518612045;17795.288188472317;17821.7326740099;5661.547076233891;6493.415592596689;6496.610203387811;6527.445167160749;6703.3296670332575;3576.7317451191266;3622.7464077514846;3716.3124821907495;3723.069232691827;3744.8876533704033;2399.5560821248123;2419.806415486757;2421.3099266708905;2423;2429.8177636676965;359.55774397491234;359.572109190063;363.91266096136735;367.83631284078865;370.7793862651718;469.72051629280526;471.5590922487485;507.1986261706495;520.5939367293518;576.6770608459192;6769.42459890905;7193.604351760599;7263.2736726328;7467.327940485274;7534.811629709301;517.6893863681836;531.0865311663932;542.9104197807318;564.8249042796746;565.2849145830528;3383.881564145243;3402.3535528249554;3512.5433693619666;3698.4637227602384;3836.854098050707;53252.733736331844;53364;53596.464035359924;53884.191737123976;54436.727816361454;45003;45748.3137752934;46105.538944610125;46136.5386346139;46676.7666161667;41905.58094419078;41924.16151676949;42300;42432;43022;7402.333789958714;7430.368418684472;7438;7670.8849367260655;7742.883856742266;29911.102666920026;30609.387812244076;30761.230969225948;31664;32152;39941.60058399495;42226.25529340583;42237.31050757935;42804.35793463038;43170.784146079066;6701.463882889455;6757.932420675927;6979.930200698132;7054.6472676367;7127.786166415016;9909.157721593458;9923.092289252781;9961.701148965543;9985.439763855748;10058.346207496783;9363.250939924654;9364.391314564531;9404.623815047322;9409.576569054547;9418.81162376735;9449.102335278138;9450.858237126586;9549.618015279311;9550.331476796835;9562.569684364082;9377.109174628673;9419.764505887408;9430.434173949585;9466.857997129911;9486.810263794547;8044.919550804651;8160.591970401338;8566.314694824523;8644.56777161152;8740.388172828096;8067.552519487395;8260;8424.873626895478;8429.114942930904;8577.571121443778 17:36:39 INFO - 2015-11-16 17:36:39,707 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:36:39 INFO - 2015-11-16 17:36:39,707 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:36:39 INFO - 2015-11-16 17:36:39,708 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 17:36:39 INFO - 2015-11-16 17:36:39,708 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:36:39 INFO - 2015-11-16 17:36:39,708 DEBUG : BROWSER_OUTPUT: __startTimestamp1447724199694__endTimestamp 17:36:39 INFO - 2015-11-16 17:36:39,708 DEBUG : BROWSER_OUTPUT: 17:36:39 INFO - 2015-11-16 17:36:39,708 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:36:39 INFO - 2015-11-16 17:36:39,709 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:36:39 INFO - 2015-11-16 17:36:39,709 DEBUG : BROWSER_OUTPUT: 17:36:39 INFO - 2015-11-16 17:36:39,709 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4885.03 Median:5088.90 stddev:524.11 (10.3%) stddev-sans-first:502.97 17:36:39 INFO - 2015-11-16 17:36:39,710 DEBUG : BROWSER_OUTPUT: Values: 2938.4 2940.3 2946.1 2987.4 3126.2 4693.3 4698.6 4792.6 4892.8 4900.4 4772.8 4795.9 4813.5 4913.3 4956.1 4457.5 4473.9 4478.6 4577.7 4596.7 4554.8 4580.7 4583.0 4622.1 4640.2 4303.8 4351.8 4441.7 4468.6 4591.2 4498.3 4529.1 4548.7 4571.6 4591.1 4484.9 4501.5 4509.1 4549.5 4562.6 4714.4 4776.0 4795.1 4809.2 4849.5 5098.6 5137.8 5138.9 5145.5 5146.1 5150.9 5160.1 5215.8 5257.9 5259.9 4714.1 4764.1 4815.9 4828.1 4848.3 5232.1 5352.8 5394.6 5426.4 5455.5 5119.2 5193.4 5204.3 5208.6 5232.2 5211.3 5254.3 5259.8 5264.3 5347.1 5161.6 5224.7 5229.6 5262.1 5263.2 5186.4 5235.3 5235.3 5266.4 5301.1 3945.4 3988.2 4083.4 4106.2 4115.8 3617.4 3621.8 3625.4 3679.7 3699.0 4820.3 4825.6 4831.4 4851.2 4896.4 5065.4 5191.8 5195.6 5262.0 5385.7 4937.1 4937.9 4947.8 4969.2 5009.4 4640.5 4679.6 4692.6 4694.2 4750.7 5224.5 5316.7 5381.1 5382.7 5461.1 5270.2 5294.2 5337.7 5337.7 5338.8 5393.6 5431.3 5440.3 5443.9 5447.5 5142.9 5163.4 5214.1 5254.2 5274.8 5305.0 5307.5 5317.2 5345.5 5418.5 5174.0 5207.3 5207.4 5218.9 5270.3 5013.3 5146.3 5158.6 5167.9 5201.9 5017.7 5028.9 5052.3 5074.4 5132.1 5146.4 5156.5 5179.1 5192.3 5201.0 4971.7 5088.9 5093.1 5112.4 5120.6 17:36:39 INFO - 2015-11-16 17:36:39,710 DEBUG : BROWSER_OUTPUT: 17:36:39 INFO - 2015-11-16 17:36:39,710 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40900.21 Median:30865.46 stddev:68691.21 (222.6%) stddev-sans-first:68816.96 17:36:39 INFO - 2015-11-16 17:36:39,711 DEBUG : BROWSER_OUTPUT: Values: 508.3 509.2 520.2 520.9 534.9 27546.2 28882.6 35557.0 35856.3 35930.0 37831.6 38274.4 38398.0 38438.2 38613.0 7354.3 8251.9 8352.5 8433.9 8451.7 7278.6 9982.0 10118.5 10141.5 10143.3 9816.6 9888.6 9904.6 9927.6 9931.0 7554.1 7705.5 9862.5 9898.1 9928.2 9699.3 9833.6 9862.3 9864.8 9894.3 35256.1 35440.6 35655.8 35739.5 35760.6 2640.1 2744.8 2992.8 3073.3 3087.3 24483.6 24598.3 24863.0 25003.2 25760.6 2074.6 2129.2 2148.7 2155.5 2281.1 231939.0 232306.0 232366.0 232505.0 232894.0 48403.0 49719.0 49826.0 51507.7 52958.0 48194.3 48338.3 48506.3 48519.0 48585.0 12730.1 12842.6 12873.2 12914.4 12937.2 9713.1 9741.5 9747.1 9778.4 9883.4 16512.7 16840.7 17013.3 17035.7 17114.7 7622.8 7850.5 7887.3 7899.6 7956.1 842.9 916.2 932.4 1012.7 1038.7 24790.6 25094.5 25537.4 25608.0 25705.4 875.4 924.3 946.2 1039.2 1051.6 12494.8 12674.7 12687.7 13353.5 13791.2 287588.0 290905.0 291076.0 291079.0 292548.0 47763.5 48123.8 48243.5 48344.8 48370.8 1238.3 1262.9 1266.4 1275.4 1277.5 24732.8 25443.9 25658.7 25725.9 25741.9 42051.2 42285.4 42483.4 42516.6 42527.4 259804.0 262502.0 263071.0 263312.0 263506.0 23617.9 23879.3 27780.6 27789.3 27797.6 34569.0 34586.5 34772.1 34779.1 35019.6 29908.0 30301.4 30878.5 31089.5 32271.0 24401.0 28959.7 29848.7 30864.4 31080.2 26661.6 26835.0 30866.5 31719.7 31854.2 26896.3 27792.7 28032.4 28121.6 28137.4 21152.0 21165.3 21323.7 21350.0 21544.7 17:36:39 INFO - 2015-11-16 17:36:39,711 DEBUG : BROWSER_OUTPUT: 17:36:39 INFO - 2015-11-16 17:36:39,711 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24688.24 Median:21915.94 stddev:84294.53 (384.6%) stddev-sans-first:84511.10 17:36:39 INFO - 2015-11-16 17:36:39,712 DEBUG : BROWSER_OUTPUT: Values: 297.5 303.2 304.9 306.8 310.4 12887.2 13331.7 15537.5 15567.8 16095.1 10450.5 10656.7 10682.5 13094.3 15586.1 3927.6 3960.0 4022.9 4035.6 4045.8 3029.9 3120.7 3920.5 4000.0 4236.1 4287.9 4288.5 4317.4 4317.6 4330.6 4217.8 4221.9 4280.1 4306.2 4319.0 3644.2 3659.3 3661.1 3683.2 3684.4 11835.2 12011.2 12207.3 12265.2 12295.0 1568.6 1577.5 1630.8 1648.8 1677.2 8476.4 8557.4 8749.0 8757.0 8860.9 1298.7 1318.5 1337.7 1389.7 1408.7 52226.2 54095.5 54313.7 54769.7 54788.7 5640.1 5789.5 5818.9 5833.1 5942.3 6530.2 6725.0 6757.7 6777.8 6794.6 4727.7 4740.6 4764.5 4779.0 4783.6 4867.1 4876.9 4936.0 5028.1 5030.6 2621.6 2671.7 2682.8 2705.6 2715.5 928.5 929.0 943.6 960.2 989.2 359.4 383.7 415.3 416.2 435.9 9925.4 10357.1 10493.3 10524.0 10635.3 361.4 396.2 405.9 426.2 428.7 5522.2 5548.0 5810.6 5890.3 5932.9 503229.0 504634.0 519382.0 522564.0 523491.0 62445.0 63166.4 63309.0 64535.7 64710.7 456.7 461.8 465.3 467.6 468.0 9936.3 9938.2 10074.4 10117.2 10118.6 31610.4 31687.7 32122.7 32136.0 32384.2 42191.6 42213.4 42844.4 42850.0 43396.0 5578.0 5653.8 5667.2 5669.2 5697.9 10329.5 10331.2 10565.6 10679.6 10688.7 8957.6 9270.7 9303.1 9355.0 9370.2 8657.7 8947.6 8981.6 9000.1 9007.0 7815.0 9115.2 9156.8 9434.1 9442.3 5059.4 5067.9 5327.4 5480.5 5488.3 8895.2 9051.7 9150.2 9161.7 9165.1 17:36:39 INFO - 2015-11-16 17:36:39,713 DEBUG : BROWSER_OUTPUT: 17:36:39 INFO - 2015-11-16 17:36:39,713 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5009.74 Median:6225.38 stddev:2568.78 (41.3%) stddev-sans-first:2559.82 17:36:39 INFO - 2015-11-16 17:36:39,714 DEBUG : BROWSER_OUTPUT: Values: 1176.1 1287.8 1324.8 1371.5 1683.3 6651.5 6814.6 6918.3 6934.9 6976.9 7177.7 7224.4 7246.0 7269.2 7316.0 2036.0 2045.4 2050.2 2053.0 2057.7 2071.3 2091.3 2094.0 2107.5 2124.9 2012.9 2044.7 2063.5 2066.4 2066.7 2014.2 2016.2 2036.0 2040.1 2045.3 2042.7 2056.0 2064.7 2081.5 2087.9 6460.6 7186.9 7205.4 7214.7 7229.7 4106.9 4290.3 4456.7 4464.0 4465.5 2571.3 2604.7 2650.7 2653.9 2671.9 818.3 825.7 1446.7 1454.4 1515.2 9698.6 9797.1 9802.5 9804.4 9834.6 3962.8 3979.3 4045.6 4050.5 4060.0 8016.6 8071.2 8072.0 8079.0 8092.4 4554.0 4571.8 4574.5 4575.6 4578.9 4173.2 4175.3 4205.4 4212.3 4218.6 3074.7 3119.3 3123.7 3149.3 3153.9 968.7 981.7 985.5 997.0 997.6 960.8 994.4 1161.7 1175.5 1175.7 6873.5 6889.0 6947.6 6948.8 6955.5 1064.8 1119.7 1142.6 1158.9 1162.4 5143.5 5373.2 5454.0 5467.6 5475.8 8130.1 8352.3 8654.2 8827.0 8862.7 8284.8 8624.6 8699.3 8707.0 8717.4 6629.6 6683.3 6697.8 6742.4 6752.8 6592.4 6675.5 6686.1 6714.4 6717.8 7476.0 7487.8 7515.2 7608.8 7633.4 7518.8 7695.5 7715.5 7782.8 7790.5 6030.0 6073.8 6085.3 6105.9 6153.8 6825.1 6906.2 6967.4 6968.2 6991.8 6297.0 6393.6 6547.2 6621.8 6640.3 6399.9 6417.9 6434.3 6475.2 6504.3 6548.2 6567.1 6567.4 6600.6 6613.9 5670.2 5841.7 5860.1 5866.6 5893.7 5825.6 5853.5 5873.7 5901.9 5914.6 17:36:39 INFO - 2015-11-16 17:36:39,714 DEBUG : BROWSER_OUTPUT: 17:36:39 INFO - 2015-11-16 17:36:39,714 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5030.40 Median:5800.29 stddev:1582.71 (27.3%) stddev-sans-first:1546.48 17:36:39 INFO - 2015-11-16 17:36:39,715 DEBUG : BROWSER_OUTPUT: Values: 280.8 285.9 292.9 294.2 298.7 5658.9 5680.5 5707.9 5752.2 5819.4 5711.1 5778.2 5798.3 5816.7 5850.0 4357.8 4357.8 4359.4 4365.5 4370.4 4148.7 4257.1 4257.8 4266.7 4351.9 4263.4 4282.1 4292.2 4296.4 4311.8 4131.2 4293.8 4299.9 4305.5 4308.3 3559.2 3587.1 3628.3 3628.9 3648.3 5509.6 5530.1 5534.9 5554.4 5574.6 4854.3 4864.3 4870.4 4876.7 4884.9 5777.9 5995.1 6003.5 6006.6 6007.3 3974.4 3995.2 3999.0 4003.3 4008.6 6222.8 6329.3 6335.0 6342.8 6344.2 4020.2 4027.3 4035.2 4039.4 4057.0 3966.0 4065.0 4076.8 4085.9 4090.6 4833.7 4842.0 4844.4 4852.4 4856.9 6027.1 6032.0 6032.4 6036.3 6047.2 1383.9 1446.6 1447.4 1450.9 1451.9 917.0 924.4 929.2 935.5 948.4 5750.5 5774.7 5789.6 5802.3 5823.7 6274.7 6282.0 6288.6 6294.7 6319.5 5732.9 5754.1 5761.9 5784.6 5786.1 3276.8 3310.8 3346.6 3363.2 3413.7 6359.4 6514.6 6556.4 6569.2 6574.5 6526.8 6532.4 6534.9 6538.5 6545.7 6330.0 6542.5 6561.7 6567.1 6572.6 6340.2 6351.6 6355.9 6359.0 6367.5 6199.8 6212.2 6235.8 6240.9 6250.0 6295.4 6501.9 6518.6 6552.9 6561.2 4054.1 4092.4 4093.3 4096.5 4110.7 6283.2 6307.1 6333.3 6342.9 6344.0 6137.7 6158.8 6158.9 6174.7 6194.4 5856.9 6004.6 6029.4 6037.7 6119.8 5955.6 5982.7 5998.7 5999.5 6001.1 6093.0 6100.4 6115.3 6117.6 6124.0 5858.7 5931.2 6024.3 6034.1 6048.2 17:36:39 INFO - 2015-11-16 17:36:39,716 DEBUG : BROWSER_OUTPUT: 17:36:39 INFO - 2015-11-16 17:36:39,716 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12314.68 Median:3119.11 stddev:14791.99 (474.2%) stddev-sans-first:14807.62 17:36:39 INFO - 2015-11-16 17:36:39,717 DEBUG : BROWSER_OUTPUT: Values: 665.7 667.3 675.8 679.5 694.6 12345.9 12376.8 12631.2 12638.6 12665.9 11770.4 11787.2 11806.8 11832.8 11868.4 644.1 659.3 797.2 811.6 818.9 797.4 799.3 809.7 811.5 813.2 822.8 823.9 830.3 835.1 835.4 655.9 670.0 821.5 829.2 843.2 623.8 625.3 627.4 628.8 633.9 12262.6 12418.8 12477.4 12478.3 12490.4 10049.1 10155.5 10443.0 10711.5 10778.8 8390.5 8416.5 8519.6 8577.7 8671.6 3016.9 3040.7 3056.1 3061.8 3070.1 44325.0 44456.8 44646.3 45078.8 45299.1 8180.8 8249.0 8256.3 8290.7 8308.5 17760.4 17778.0 17792.6 17795.3 17821.7 5661.5 6493.4 6496.6 6527.4 6703.3 3576.7 3622.7 3716.3 3723.1 3744.9 2399.6 2419.8 2421.3 2423.0 2429.8 359.6 359.6 363.9 367.8 370.8 469.7 471.6 507.2 520.6 576.7 6769.4 7193.6 7263.3 7467.3 7534.8 517.7 531.1 542.9 564.8 565.3 3383.9 3402.4 3512.5 3698.5 3836.9 53252.7 53364.0 53596.5 53884.2 54436.7 45003.0 45748.3 46105.5 46136.5 46676.8 41905.6 41924.2 42300.0 42432.0 43022.0 7402.3 7430.4 7438.0 7670.9 7742.9 29911.1 30609.4 30761.2 31664.0 32152.0 39941.6 42226.3 42237.3 42804.4 43170.8 6701.5 6757.9 6979.9 7054.6 7127.8 9909.2 9923.1 9961.7 9985.4 10058.3 9363.3 9364.4 9404.6 9409.6 9418.8 9449.1 9450.9 9549.6 9550.3 9562.6 9377.1 9419.8 9430.4 9466.9 9486.8 8044.9 8160.6 8566.3 8644.6 8740.4 8067.6 8260.0 8424.9 8429.1 8577.6 17:36:39 INFO - 2015-11-16 17:36:39,717 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:36:39 INFO - 2015-11-16 17:36:39,717 DEBUG : BROWSER_OUTPUT: 17:36:40 INFO - 2015-11-16 17:36:40,357 INFO : Browser exited with error code: 0 17:36:40 INFO - 2015-11-16 17:36:40,386 INFO : Completed test dromaeo_css (00:18:35) 17:36:40 INFO - 2015-11-16 17:36:40,386 INFO : Starting test kraken 17:36:40 INFO - 2015-11-16 17:36:40,386 DEBUG : operating with platform_type : mac_ 17:36:40 INFO - 2015-11-16 17:36:40,387 INFO : Initialising browser for kraken test... 17:36:40 INFO - 2015-11-16 17:36:40,401 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpB7iZbM/profile http://localhost:50757/getInfo.html 17:36:42 INFO - 2015-11-16 17:36:42,767 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:36:42 INFO - 2015-11-16 17:36:42,767 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:36:42 INFO - 2015-11-16 17:36:42,768 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:36:42 INFO - 2015-11-16 17:36:42,768 DEBUG : BROWSER_OUTPUT: __metrics 17:36:42 INFO - 2015-11-16 17:36:42,783 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:36:43 INFO - 2015-11-16 17:36:43,537 INFO : Browser initialized. 17:36:43 INFO - 2015-11-16 17:36:43,538 INFO : Running cycle 1/1 for kraken test... 17:36:43 INFO - 2015-11-16 17:36:43,538 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmpB7iZbM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:36:55 INFO - 2015-11-16 17:36:55,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 228540416 17:36:55 INFO - 2015-11-16 17:36:55,594 DEBUG : BROWSER_OUTPUT: 17:36:58 INFO - 2015-11-16 17:36:58,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50757/tests/kraken/driver.html?testName=audio-beat-detection) 17:36:58 INFO - 2015-11-16 17:36:58,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 285155328 17:36:58 INFO - 2015-11-16 17:36:58,777 DEBUG : BROWSER_OUTPUT: 17:37:01 INFO - 2015-11-16 17:37:01,656 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50757/tests/kraken/driver.html?testName=audio-dft) 17:37:02 INFO - 2015-11-16 17:37:02,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 297795584 17:37:02 INFO - 2015-11-16 17:37:02,240 DEBUG : BROWSER_OUTPUT: 17:37:05 INFO - 2015-11-16 17:37:05,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50757/tests/kraken/driver.html?testName=audio-fft) 17:37:06 INFO - 2015-11-16 17:37:06,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 281350144 17:37:06 INFO - 2015-11-16 17:37:06,032 DEBUG : BROWSER_OUTPUT: 17:37:08 INFO - 2015-11-16 17:37:08,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50757/tests/kraken/driver.html?testName=audio-oscillator) 17:37:08 INFO - 2015-11-16 17:37:08,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 283512832 17:37:08 INFO - 2015-11-16 17:37:08,774 DEBUG : BROWSER_OUTPUT: 17:37:11 INFO - 2015-11-16 17:37:11,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50757/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:11 INFO - 2015-11-16 17:37:11,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 282886144 17:37:11 INFO - 2015-11-16 17:37:11,703 DEBUG : BROWSER_OUTPUT: 17:37:15 INFO - 2015-11-16 17:37:15,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50757/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:15 INFO - 2015-11-16 17:37:15,614 DEBUG : BROWSER_OUTPUT: RSS: Main: 283742208 17:37:15 INFO - 2015-11-16 17:37:15,614 DEBUG : BROWSER_OUTPUT: 17:37:19 INFO - 2015-11-16 17:37:19,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50757/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:19 INFO - 2015-11-16 17:37:19,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 283688960 17:37:19 INFO - 2015-11-16 17:37:19,636 DEBUG : BROWSER_OUTPUT: 17:37:22 INFO - 2015-11-16 17:37:22,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50757/tests/kraken/driver.html?testName=json-parse-financial) 17:37:23 INFO - 2015-11-16 17:37:23,322 DEBUG : BROWSER_OUTPUT: RSS: Main: 283971584 17:37:23 INFO - 2015-11-16 17:37:23,322 DEBUG : BROWSER_OUTPUT: 17:37:24 INFO - 2015-11-16 17:37:24,972 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50757/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:25 INFO - 2015-11-16 17:37:25,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 319496192 17:37:25 INFO - 2015-11-16 17:37:25,542 DEBUG : BROWSER_OUTPUT: 17:37:27 INFO - 2015-11-16 17:37:27,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:28 INFO - 2015-11-16 17:37:28,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 317751296 17:37:28 INFO - 2015-11-16 17:37:28,105 DEBUG : BROWSER_OUTPUT: 17:37:30 INFO - 2015-11-16 17:37:30,362 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:30 INFO - 2015-11-16 17:37:30,941 DEBUG : BROWSER_OUTPUT: RSS: Main: 326955008 17:37:30 INFO - 2015-11-16 17:37:30,941 DEBUG : BROWSER_OUTPUT: 17:37:33 INFO - 2015-11-16 17:37:33,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:34 INFO - 2015-11-16 17:37:34,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 329015296 17:37:34 INFO - 2015-11-16 17:37:34,347 DEBUG : BROWSER_OUTPUT: 17:37:37 INFO - 2015-11-16 17:37:37,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:37 INFO - 2015-11-16 17:37:37,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 327786496 17:37:37 INFO - 2015-11-16 17:37:37,776 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,623 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50757/tests/kraken/driver.html?testName=ai-astar) 17:37:39 INFO - 2015-11-16 17:37:39,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 387690496 17:37:39 INFO - 2015-11-16 17:37:39,882 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,883 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:37:39 INFO - 2015-11-16 17:37:39,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:37:39 INFO - 2015-11-16 17:37:39,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:37:39 INFO - 2015-11-16 17:37:39,883 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:37:39 INFO - 2015-11-16 17:37:39,883 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;109;110;111;110;116;109;111;106;112 17:37:39 INFO - 2015-11-16 17:37:39,883 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;175;147;173;188;144;169;166;141;183;143 17:37:39 INFO - 2015-11-16 17:37:39,883 DEBUG : BROWSER_OUTPUT: |2;audio-dft;173;180;181;180;175;182;179;178;172;209 17:37:39 INFO - 2015-11-16 17:37:39,884 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;90;101;96;76;78;80;92;97;79 17:37:39 INFO - 2015-11-16 17:37:39,884 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;106;110;151;98;100;100;139;99;98;144 17:37:39 INFO - 2015-11-16 17:37:39,884 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;135;135;129;135;134;136;135;129;129;135 17:37:39 INFO - 2015-11-16 17:37:39,884 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;141;142;142;141;141;141;141;147;142;141 17:37:39 INFO - 2015-11-16 17:37:39,884 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;113;106;109;116;105;113;118;117;105;104 17:37:39 INFO - 2015-11-16 17:37:39,884 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;63;63;65;66;66;65;75;65;65 17:37:39 INFO - 2015-11-16 17:37:39,884 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;73;76;78;77;77;78;77;86;78 17:37:39 INFO - 2015-11-16 17:37:39,885 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;95;98;100;98;96;97;97;98;97 17:37:39 INFO - 2015-11-16 17:37:39,885 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;139;155;152;143;154;135;149;145;145;145 17:37:39 INFO - 2015-11-16 17:37:39,885 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;157;179;162;171;173;159;176;173;174;160 17:37:39 INFO - 2015-11-16 17:37:39,885 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;74;77;80;80;79;78;82;81;82;79 17:37:39 INFO - 2015-11-16 17:37:39,885 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:37:39 INFO - 2015-11-16 17:37:39,886 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:37:39 INFO - 2015-11-16 17:37:39,886 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,940 17:37:39 INFO - 2015-11-16 17:37:39,886 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:37:39 INFO - 2015-11-16 17:37:39,886 DEBUG : BROWSER_OUTPUT: __startTimestamp1447724259878__endTimestamp 17:37:39 INFO - 2015-11-16 17:37:39,886 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,886 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:37:39 INFO - 2015-11-16 17:37:39,887 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:37:39 INFO - 2015-11-16 17:37:39,887 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,887 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:2.55 (2.3%) stddev-sans-first:2.70 17:37:39 INFO - 2015-11-16 17:37:39,887 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 111.0 110.0 116.0 109.0 111.0 106.0 112.0 17:37:39 INFO - 2015-11-16 17:37:39,887 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,888 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:162.90 Median:171.00 stddev:17.69 (10.3%) stddev-sans-first:18.21 17:37:39 INFO - 2015-11-16 17:37:39,888 DEBUG : BROWSER_OUTPUT: Values: 175.0 147.0 173.0 188.0 144.0 169.0 166.0 141.0 183.0 143.0 17:37:39 INFO - 2015-11-16 17:37:39,888 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,888 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:180.90 Median:180.00 stddev:10.44 (5.8%) stddev-sans-first:10.67 17:37:39 INFO - 2015-11-16 17:37:39,888 DEBUG : BROWSER_OUTPUT: Values: 173.0 180.0 181.0 180.0 175.0 182.0 179.0 178.0 172.0 209.0 17:37:39 INFO - 2015-11-16 17:37:39,888 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,889 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:86.60 Median:85.00 stddev:9.57 (11.3%) stddev-sans-first:9.50 17:37:39 INFO - 2015-11-16 17:37:39,889 DEBUG : BROWSER_OUTPUT: Values: 77.0 90.0 101.0 96.0 76.0 78.0 80.0 92.0 97.0 79.0 17:37:39 INFO - 2015-11-16 17:37:39,889 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,889 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:114.50 Median:147.50 stddev:21.35 (14.5%) stddev-sans-first:22.42 17:37:39 INFO - 2015-11-16 17:37:39,889 DEBUG : BROWSER_OUTPUT: Values: 106.0 110.0 151.0 98.0 100.0 100.0 139.0 99.0 98.0 144.0 17:37:39 INFO - 2015-11-16 17:37:39,889 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,889 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:133.20 Median:135.00 stddev:2.94 (2.2%) stddev-sans-first:3.04 17:37:39 INFO - 2015-11-16 17:37:39,890 DEBUG : BROWSER_OUTPUT: Values: 135.0 135.0 129.0 135.0 134.0 136.0 135.0 129.0 129.0 135.0 17:37:39 INFO - 2015-11-16 17:37:39,890 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,890 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:141.90 Median:141.50 stddev:1.85 (1.3%) stddev-sans-first:1.94 17:37:39 INFO - 2015-11-16 17:37:39,890 DEBUG : BROWSER_OUTPUT: Values: 141.0 142.0 142.0 141.0 141.0 141.0 141.0 147.0 142.0 141.0 17:37:39 INFO - 2015-11-16 17:37:39,890 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,891 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:110.60 Median:113.00 stddev:5.44 (4.8%) stddev-sans-first:5.70 17:37:39 INFO - 2015-11-16 17:37:39,891 DEBUG : BROWSER_OUTPUT: Values: 113.0 106.0 109.0 116.0 105.0 113.0 118.0 117.0 105.0 104.0 17:37:39 INFO - 2015-11-16 17:37:39,891 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,891 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:3.50 (5.4%) stddev-sans-first:3.59 17:37:39 INFO - 2015-11-16 17:37:39,891 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 65.0 66.0 66.0 65.0 75.0 65.0 65.0 17:37:39 INFO - 2015-11-16 17:37:39,891 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,892 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:77.10 Median:77.50 stddev:3.90 (5.0%) stddev-sans-first:3.46 17:37:39 INFO - 2015-11-16 17:37:39,892 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 76.0 78.0 77.0 77.0 78.0 77.0 86.0 78.0 17:37:39 INFO - 2015-11-16 17:37:39,892 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,892 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:97.10 Median:97.00 stddev:1.52 (1.6%) stddev-sans-first:1.41 17:37:39 INFO - 2015-11-16 17:37:39,892 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 98.0 100.0 98.0 96.0 97.0 97.0 98.0 97.0 17:37:39 INFO - 2015-11-16 17:37:39,892 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,892 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:147.00 stddev:6.43 (4.4%) stddev-sans-first:6.26 17:37:39 INFO - 2015-11-16 17:37:39,893 DEBUG : BROWSER_OUTPUT: Values: 139.0 155.0 152.0 143.0 154.0 135.0 149.0 145.0 145.0 145.0 17:37:39 INFO - 2015-11-16 17:37:39,893 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,893 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:173.00 stddev:8.03 (4.6%) stddev-sans-first:7.38 17:37:39 INFO - 2015-11-16 17:37:39,893 DEBUG : BROWSER_OUTPUT: Values: 157.0 179.0 162.0 171.0 173.0 159.0 176.0 173.0 174.0 160.0 17:37:39 INFO - 2015-11-16 17:37:39,893 DEBUG : BROWSER_OUTPUT: 17:37:39 INFO - 2015-11-16 17:37:39,893 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.20 Median:80.00 stddev:2.44 (3.1%) stddev-sans-first:1.72 17:37:39 INFO - 2015-11-16 17:37:39,893 DEBUG : BROWSER_OUTPUT: Values: 74.0 77.0 80.0 80.0 79.0 78.0 82.0 81.0 82.0 79.0 17:37:39 INFO - 2015-11-16 17:37:39,895 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:37:39 INFO - 2015-11-16 17:37:39,895 DEBUG : BROWSER_OUTPUT: 17:37:40 INFO - 2015-11-16 17:37:40,584 INFO : Browser exited with error code: 0 17:37:40 INFO - 2015-11-16 17:37:40,639 INFO : Completed test kraken (00:01:00) 17:37:40 INFO - 2015-11-16 17:37:40,639 INFO : Starting test v8_7 17:37:40 INFO - 2015-11-16 17:37:40,639 DEBUG : operating with platform_type : mac_ 17:37:40 INFO - 2015-11-16 17:37:40,639 INFO : Initialising browser for v8_7 test... 17:37:40 INFO - 2015-11-16 17:37:40,654 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmp8kfe5X/profile http://localhost:50757/getInfo.html 17:37:43 INFO - 2015-11-16 17:37:43,009 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:37:43 INFO - 2015-11-16 17:37:43,009 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:37:43 INFO - 2015-11-16 17:37:43,009 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:37:43 INFO - 2015-11-16 17:37:43,009 DEBUG : BROWSER_OUTPUT: __metrics 17:37:43 INFO - 2015-11-16 17:37:43,025 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:37:43 INFO - 2015-11-16 17:37:43,737 INFO : Browser initialized. 17:37:43 INFO - 2015-11-16 17:37:43,737 INFO : Running cycle 1/1 for v8_7 test... 17:37:43 INFO - 2015-11-16 17:37:43,738 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/T/tmp8kfe5X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:37:55 INFO - 2015-11-16 17:37:55,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 229584896 17:37:55 INFO - 2015-11-16 17:37:55,846 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50757/tests/v8_7/run.html (next: http://localhost:50757/tests/v8_7/run.html) 17:38:18 INFO - 2015-11-16 17:38:18,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 728477696 17:38:18 INFO - 2015-11-16 17:38:18,965 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,967 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:38:18 INFO - 2015-11-16 17:38:18,967 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:38:18 INFO - 2015-11-16 17:38:18,967 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:38:18 INFO - 2015-11-16 17:38:18,967 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:38:18 INFO - 2015-11-16 17:38:18,967 DEBUG : BROWSER_OUTPUT: |0;Richards;174.85574401119078 17:38:18 INFO - 2015-11-16 17:38:18,968 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;226.70596236681024 17:38:18 INFO - 2015-11-16 17:38:18,968 DEBUG : BROWSER_OUTPUT: |2;Encrypt;357.27045373347624 17:38:18 INFO - 2015-11-16 17:38:18,968 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6369.426751592357 17:38:18 INFO - 2015-11-16 17:38:18,968 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2102.9411764705883 17:38:18 INFO - 2015-11-16 17:38:18,968 DEBUG : BROWSER_OUTPUT: |5;Earley;1014.1987829614604 17:38:18 INFO - 2015-11-16 17:38:18,969 DEBUG : BROWSER_OUTPUT: |6;Boyer;14579.710144927536 17:38:18 INFO - 2015-11-16 17:38:18,969 DEBUG : BROWSER_OUTPUT: |7;RegExp;32596.774193548386 17:38:18 INFO - 2015-11-16 17:38:18,969 DEBUG : BROWSER_OUTPUT: |8;Splay;826.4462809917355 17:38:18 INFO - 2015-11-16 17:38:18,969 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6416.666666666667 17:38:18 INFO - 2015-11-16 17:38:18,969 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:38:18 INFO - 2015-11-16 17:38:18,969 DEBUG : BROWSER_OUTPUT: __startTimestamp1447724298965__endTimestamp 17:38:18 INFO - 2015-11-16 17:38:18,970 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,970 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:38:18 INFO - 2015-11-16 17:38:18,970 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:38:18 INFO - 2015-11-16 17:38:18,970 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,970 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:174.86 Median:174.86 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-16 17:38:18,971 DEBUG : BROWSER_OUTPUT: Values: 174.9 17:38:18 INFO - 2015-11-16 17:38:18,971 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,971 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:226.71 Median:226.71 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-16 17:38:18,971 DEBUG : BROWSER_OUTPUT: Values: 226.7 17:38:18 INFO - 2015-11-16 17:38:18,971 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,971 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:357.27 Median:357.27 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-16 17:38:18,971 DEBUG : BROWSER_OUTPUT: Values: 357.3 17:38:18 INFO - 2015-11-16 17:38:18,972 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,972 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6369.43 Median:6369.43 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-16 17:38:18,972 DEBUG : BROWSER_OUTPUT: Values: 6369.4 17:38:18 INFO - 2015-11-16 17:38:18,972 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,972 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2102.94 Median:2102.94 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-16 17:38:18,972 DEBUG : BROWSER_OUTPUT: Values: 2102.9 17:38:18 INFO - 2015-11-16 17:38:18,972 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,972 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1014.20 Median:1014.20 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-16 17:38:18,973 DEBUG : BROWSER_OUTPUT: Values: 1014.2 17:38:18 INFO - 2015-11-16 17:38:18,973 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,973 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14579.71 Median:14579.71 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-16 17:38:18,973 DEBUG : BROWSER_OUTPUT: Values: 14579.7 17:38:18 INFO - 2015-11-16 17:38:18,973 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,974 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32596.77 Median:32596.77 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-16 17:38:18,974 DEBUG : BROWSER_OUTPUT: Values: 32596.8 17:38:18 INFO - 2015-11-16 17:38:18,974 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,975 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:826.45 Median:826.45 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-16 17:38:18,975 DEBUG : BROWSER_OUTPUT: Values: 826.4 17:38:18 INFO - 2015-11-16 17:38:18,975 DEBUG : BROWSER_OUTPUT: 17:38:18 INFO - 2015-11-16 17:38:18,975 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6416.67 Median:6416.67 stddev:0.00 (0.0%) 17:38:18 INFO - 2015-11-16 17:38:18,975 DEBUG : BROWSER_OUTPUT: Values: 6416.7 17:38:18 INFO - 2015-11-16 17:38:18,975 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:38:18 INFO - 2015-11-16 17:38:18,975 DEBUG : BROWSER_OUTPUT: 17:38:19 INFO - 2015-11-16 17:38:19,702 INFO : Browser exited with error code: 0 17:38:19 INFO - 2015-11-16 17:38:19,725 INFO : Completed test v8_7 (00:00:39) 17:38:20 INFO - 2015-11-16 17:38:20,155 INFO : Completed test suite (00:20:15) 17:38:20 INFO - 2015-11-16 17:38:20,155 DEBUG : Working with test: dromaeo_css 17:38:20 INFO - 2015-11-16 17:38:20,155 DEBUG : Generating results file: dromaeo_css 17:38:20 INFO - 2015-11-16 17:38:20,156 DEBUG : Working with test: kraken 17:38:20 INFO - 2015-11-16 17:38:20,156 DEBUG : Generating results file: kraken 17:38:20 INFO - 2015-11-16 17:38:20,156 INFO : javascript benchmark 17:38:20 INFO - 2015-11-16 17:38:20,156 DEBUG : Working with test: v8_7 17:38:20 INFO - 2015-11-16 17:38:20,157 DEBUG : Generating results file: v8_7 17:38:20 INFO - 2015-11-16 17:38:20,157 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:38:20 INFO - 2015-11-16 17:38:20,209 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 17:38:20 INFO - 2015-11-16 17:38:20,209 DEBUG : process_Request line: dromaeo_css 6025.10 graph.html#tests=[[72,64,55]] 17:38:20 INFO - 2015-11-16 17:38:20,209 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:38:20 INFO - 2015-11-16 17:38:20,236 DEBUG : process_Request line: kraken 1674.60 graph.html#tests=[[232,64,55]] 17:38:20 INFO - 2015-11-16 17:38:20,236 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:38:20 INFO - 2015-11-16 17:38:20,263 DEBUG : process_Request line: v8_7 16264.27 graph.html#tests=[[230,64,55]] 17:38:20 INFO - 2015-11-16 17:38:20,264 INFO : javascript benchmark 17:38:20 INFO - 2015-11-16 17:38:20,266 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [297.49871466578804, 303.2101375915739, 304.91919641295044, 306.8220432149354, 310.4334589374392, 12887.162334448254, 13331.733365332688, 15537.53387398377, 15567.84432155678, 16095.114768687732, 10450.477476126182, 10656.680299591024, 10682.51928663212, 13094.279814610192, 15586.142762148078, 3927.646511813943, 3960.0297927007923, 4022.919541609166, 4035.556088830226, 4045.757254564721, 3029.8939537116207, 3120.6723294054136, 3920.529536455615, 4000.0, 4236.089240813225, 4287.871363859089, 4288.485381754178, 4317.352397140438, 4317.568243175689, 4330.631896288819, 4217.7891105444605, 4221.936670949938, 4280.058387154821, 4306.181825453185, 4318.9784051079705, 3644.2164934538937, 3659.3413185626578, 3661.139632186434, 3683.226522430293, 3684.355237833395, 11835.171537992344, 12011.219270747373, 12207.328596927166, 12265.202761820543, 12295.0, 1568.5529624057203, 1577.495201535509, 1630.7879975603096, 1648.7609296651917, 1677.2284749015469, 8476.449030812977, 8557.400981931267, 8749.0, 8757.0, 8860.8670869937, 1298.681822953373, 1318.4792007157216, 1337.6722702937745, 1389.7359501694646, 1408.7319415740649, 52226.21660675093, 54095.45904540983, 54313.72843135799, 54769.72615136939, 54788.72605636986, 5640.125780504029, 5789.478946894799, 5818.854528636733, 5833.095870140135, 5942.257217847769, 6530.216374035146, 6725.0, 6757.662116894136, 6777.796666100025, 6794.626295553792, 4727.669063165614, 4740.597049250783, 4764.499727528629, 4779.044191161782, 4783.5933945614315, 4867.099586576494, 4876.926846097312, 4936.0, 5028.120078986163, 5030.597552195815, 2621.5936529837904, 2671.7061123276426, 2682.771964383049, 2705.6076868853906, 2715.4840580289683, 928.4661319741176, 928.9814203716023, 943.6036864516919, 960.2462067277154, 989.2185173712686, 359.3926264612796, 383.70646455461593, 415.3479037910512, 416.1780483545035, 435.8801329634376, 9925.404475731479, 10357.119644830274, 10493.265471416928, 10524.0, 10635.255532112833, 361.41631265506544, 396.2352659367391, 405.9309917314064, 426.2157629960887, 428.74918172869224, 5522.199281104217, 5548.0, 5810.564207684441, 5890.263717035371, 5932.940670593239, 503229.0, 504634.0, 519382.0, 522564.0, 523491.0, 62445.0, 63166.36833631697, 63309.0, 64535.67732161309, 64710.676446617465, 456.67576021025445, 461.8452818305905, 465.3485120830864, 467.5675000624409, 467.9766011699401, 9936.304458687822, 9938.204943604349, 10074.395536267848, 10117.190624749855, 10118.645847395306, 31610.36779264356, 31687.683123168474, 32122.67877321197, 32136.0, 32384.190395240308, 42191.57808421877, 42213.36679949742, 42844.35733464063, 42850.0, 43396.0, 5578.0, 5653.802116925888, 5667.1782591524825, 5669.206311116364, 5697.914531282117, 10329.535170917177, 10331.225158113322, 10565.63020294286, 10679.626213082505, 10688.732781680521, 8957.641694332153, 9270.675526356545, 9303.069693030913, 9355.0, 9370.203532699798, 8657.696980605648, 8947.59735811903, 8981.640734370552, 9000.099990000948, 9006.954965225132, 7815.0, 9115.179633832988, 9156.816863662823, 9434.103760142776, 9442.339036267671, 5059.367579052619, 5067.87330316745, 5327.440618734977, 5480.479354461319, 5488.341399032141, 8895.154960278764, 9051.728448146567, 9150.176484116462, 9161.725148245563, 9165.083491651048], "dojo.html": [2938.3829395826874, 2940.2796314902866, 2946.1014390610853, 2987.447322245385, 3126.2497000719827, 4693.342931989516, 4698.600618947389, 4792.6405519586, 4892.828750993716, 4900.436449808273, 4772.832950846712, 4795.928061079087, 4813.518648135194, 4913.287573301878, 4956.132676781558, 4457.531959144292, 4473.932891006638, 4478.619317358012, 4577.748223847687, 4596.747178905159, 4554.795034223452, 4580.748058856761, 4583.0, 4622.075584883037, 4640.164770341337, 4303.763293018883, 4351.782410879443, 4441.689081764278, 4468.620167285784, 4591.150637132125, 4498.257787465064, 4529.139463501924, 4548.658850586219, 4571.6114130298965, 4591.104734576759, 4484.8878778030485, 4501.504834468205, 4509.120721459317, 4549.499555048942, 4562.634989200856, 4714.387129673155, 4776.044791041805, 4795.112904112715, 4809.23052311632, 4849.490803465621, 5098.566621837148, 5137.845864624067, 5138.871528211825, 5145.485451454824, 5146.099432599281, 5150.922736158961, 5160.122779127557, 5215.791368345262, 5257.947420525784, 5259.921101183485, 4714.104320179189, 4764.071006153836, 4815.927761083586, 4828.106800241966, 4848.272759086095, 5232.110541208004, 5352.759125839347, 5394.62237643369, 5426.403095659474, 5455.454454554513, 5119.1553393690365, 5193.350831146106, 5204.271402003723, 5208.635395522353, 5232.189010703347, 5211.348581427322, 5254.3169387979315, 5259.8422047338645, 5264.289320941624, 5347.064263753905, 5161.612879034087, 5224.738763061831, 5229.633925625246, 5262.052830490472, 5263.157894736823, 5186.351706036746, 5235.319408476874, 5235.345581802275, 5266.3943646480375, 5301.125314323171, 3945.447637330776, 3988.222296652125, 4083.4283200351974, 4106.2198182345255, 4115.814788334532, 3617.4212126059706, 3621.8370173342264, 3625.41993281079, 3679.7424180307657, 3699.0197597636648, 4820.30105634681, 4825.638077144228, 4831.396075490564, 4851.175300198975, 4896.436909755353, 5065.39215294167, 5191.8182863599595, 5195.584353251731, 5261.973690131525, 5385.676859388449, 4937.086638971802, 4937.925931111036, 4947.82682606107, 4969.229769385751, 5009.373828271466, 4640.466346370143, 4679.64902632304, 4692.601128904013, 4694.1550520905885, 4750.714957102585, 5224.50367215114, 5316.680999140064, 5381.085215513293, 5382.7308634567335, 5461.098918678374, 5270.156774915995, 5294.232336311136, 5337.679739215504, 5337.6797392156595, 5338.786448542171, 5393.568514518751, 5431.34823821144, 5440.347158341025, 5443.863903402446, 5447.470817120648, 5142.8971420572125, 5163.380394352702, 5214.113600687816, 5254.15933450646, 5274.762635681327, 5305.0, 5307.548858347083, 5317.229001794795, 5345.492178243061, 5418.539424148991, 5174.0, 5207.3490813648295, 5207.401148867929, 5218.8956220876125, 5270.288511050959, 5013.273075403973, 5146.25379319989, 5158.638895277295, 5167.870803229799, 5201.895962080813, 5017.698938063728, 5028.899422011466, 5052.292679024866, 5074.391073071255, 5132.050570644443, 5146.356705411824, 5156.484351564964, 5179.1454410021925, 5192.299039629753, 5201.0, 4971.676841005323, 5088.898222035613, 5093.1341671915125, 5112.3865136183895, 5120.564751996122], "mootools.html": [1176.0591526778576, 1287.7617640736462, 1324.8079028540863, 1371.5473893615108, 1683.2509533257698, 6651.4678825693945, 6814.5911245325315, 6918.308169183079, 6934.861302773941, 6976.860462790741, 7177.712891484334, 7224.422046236302, 7245.963770181142, 7269.236730143325, 7316.0, 2036.0430597619131, 2045.447729113146, 2050.2106688924796, 2052.9897350513224, 2057.660486019805, 2071.2957594417894, 2091.299414696071, 2094.0, 2107.4942013916702, 2124.8618839775363, 2012.8792272463627, 2044.7239622650975, 2063.515073957619, 2066.442060643625, 2066.741657292838, 2014.1641218894142, 2016.1632922337212, 2036.0125339210472, 2040.1125510403022, 2045.3148195354574, 2042.714020037196, 2055.9794402056086, 2064.7315848939543, 2081.5420607466335, 2087.885166315852, 6460.612363258219, 7186.856262874766, 7205.35151836332, 7214.74748383804, 7229.746958856467, 4106.897327566835, 4290.292101803198, 4456.6880318377725, 4463.977680111611, 4465.508794032654, 2571.2800415883585, 2604.6744156980376, 2650.681918169813, 2653.8938442462277, 2671.906483273076, 818.3412353055787, 825.6862392290951, 1446.6889618731918, 1454.4036944852664, 1515.1893736850732, 9698.563564639608, 9797.118259356692, 9802.509874506246, 9804.411735295906, 9834.606615735362, 3962.841486340572, 3979.323515002399, 4045.6156665117355, 4050.4734384529825, 4060.045889216032, 8016.639251233709, 8071.23323284287, 8072.0, 8078.959605201936, 8092.352611791042, 4554.0, 4571.771411429415, 4574.4739354973935, 4575.565321294472, 4578.88552786183, 4173.1862286854375, 4175.269327867672, 4205.3902184183125, 4212.347086201644, 4218.557051509609, 3074.723274905269, 3119.3293441909645, 3123.7188653021335, 3149.2914094328594, 3153.936921261608, 968.651285537206, 981.6760469045198, 985.4776968206719, 997.042838874674, 997.5560875410373, 960.7790208252142, 994.3834822410151, 1161.6573110932295, 1175.5297880847559, 1175.6766889105393, 6873.48448866327, 6889.0355350251, 6947.617881016491, 6948.791536253921, 6955.513114081966, 1064.834950582661, 1119.652907598647, 1142.5601143559788, 1158.901493373056, 1162.3723189477757, 5143.5113664201845, 5373.194020896819, 5453.972730136324, 5467.562594992471, 5475.753591088411, 8130.105688374274, 8352.290055345242, 8654.177853103945, 8827.0, 8862.689805856764, 8284.751457456287, 8624.568771561397, 8699.347548933856, 8707.042225355206, 8717.433366831136, 6629.569078009914, 6683.331666833278, 6697.7655782047395, 6742.42689371409, 6752.797416077526, 6592.43964263043, 6675.499337549801, 6686.0973768540625, 6714.4292735116105, 6717.764878229238, 7475.962620186864, 7487.775366739006, 7515.210902855121, 7608.80977975555, 7633.389328853789, 7518.849623007619, 7695.461317707706, 7715.537067775951, 7782.805429864298, 7790.493617914817, 6030.0, 6073.817785466443, 6085.269767627913, 6105.877882442237, 6153.784617538365, 6825.1127353443735, 6906.171259448898, 6967.407770339578, 6968.163820341389, 6991.755288564876, 6296.968515157395, 6393.552451328548, 6547.214334279917, 6621.768238111643, 6640.269570347355, 6399.904001439889, 6417.903731444126, 6434.292227855026, 6475.222973243241, 6504.317046710027, 6548.214214294315, 6567.146270984741, 6567.408933196035, 6600.570962887397, 6613.900791488035, 5670.234518340137, 5841.737121829443, 5860.062390017577, 5866.6480011199465, 5893.734781934738, 5825.592208545361, 5853.531717462508, 5873.706314684163, 5901.911471327848, 5914.585978981602], "ext.html": [508.3112382721412, 509.20055512844823, 520.1755217979502, 520.8697825543614, 534.871630808606, 27546.17361479154, 28882.566761498594, 35557.0, 35856.2828743425, 35930.0, 37831.62168378315, 38274.4258836117, 38398.0, 38438.23123537528, 38613.0, 7354.264573542657, 8251.876221856677, 8352.498850068985, 8433.915660843406, 8451.74644760655, 7278.636068196595, 9981.950090249538, 10118.494075296243, 10141.543630536644, 10143.340682855627, 9816.6073357066, 9888.604455821758, 9904.603815847357, 9927.602895884156, 9931.0, 7554.131274903347, 7705.537667739954, 9862.45756483393, 9898.059684329977, 9928.156106730901, 9699.321047526675, 9833.557489912899, 9862.260330475172, 9864.753381165528, 9894.257930655158, 35256.11859703528, 35440.645593543995, 35655.82172089149, 35739.4639080414, 35760.64239357625, 2640.1287575100173, 2744.8266936138093, 2992.7905046646742, 3073.3085055862252, 3087.2744904947544, 24483.632745508654, 24598.262052138463, 24863.0, 25003.249902502954, 25760.613590796154, 2074.647309957311, 2129.2228336657163, 2148.6828723552703, 2155.5257843274453, 2281.0761641535205, 231939.0, 232306.0, 232366.0, 232505.0, 232894.0, 48403.0, 49719.0, 49826.013918887125, 51507.7424612882, 52958.0, 48194.27708584304, 48338.27492587614, 48506.27240591394, 48519.0, 48585.0, 12730.10889237763, 12842.550510732079, 12873.22760634365, 12914.354282285849, 12937.223766574036, 9713.07725766051, 9741.512924353754, 9747.074027967332, 9778.41329520231, 9883.357581757164, 16512.669746605, 16840.66318673644, 17013.31946722142, 17035.659286814196, 17114.743278850827, 7622.771316860503, 7850.528968261922, 7887.290143887078, 7899.565523896241, 7956.124826269106, 842.8609279468819, 916.2074805293373, 932.3520153493257, 1012.6607586458472, 1038.7403149212696, 24790.628140577905, 25094.498110037697, 25537.36156596063, 25608.0, 25705.357366065626, 875.4003507597316, 924.2929159193222, 946.2240962410757, 1039.1946241662772, 1051.5741124844296, 12494.75010499785, 12674.683132921751, 12687.746245075046, 13353.46586136563, 13791.241481718402, 287588.0, 290905.0, 291076.0, 291079.0, 292548.0, 47763.522364775905, 48123.75938120357, 48243.5175648239, 48344.75827620839, 48370.758146209046, 1238.3374894431436, 1262.9431675574438, 1266.4364357860848, 1275.4451813461174, 1277.5273148934953, 24732.752672473045, 25443.87278063672, 25658.743412565636, 25725.871370643028, 25741.871290644176, 42051.1589768209, 42285.36571951485, 42483.36274955816, 42516.5748342525, 42527.3620895693, 259804.0, 262502.0, 263071.0, 263312.0, 263506.0, 23617.866873297447, 23879.283621491384, 27780.583291250245, 27789.30526736767, 27797.583036254877, 34569.0, 34586.48120278148, 34772.13069673177, 34779.130521737156, 35019.64980350164, 29908.0, 30301.393972119993, 30878.53682194724, 31089.53365699471, 32271.0, 24401.0, 28959.710402896544, 29848.701512984593, 30864.382712346076, 31080.22299442532, 26661.600075999264, 26835.0, 30866.53700194454, 31719.682803171672, 31854.203644908135, 26896.32759181036, 27792.72207277901, 28032.439351212455, 28121.578176326962, 28137.44226787666, 21152.0, 21165.25921592737, 21323.68014479753, 21350.0, 21544.676829847253], "prototype.html": [280.80764676196804, 285.91565488180987, 292.88577454792636, 294.2320543381775, 298.70875896001417, 5658.943410565893, 5680.545556355492, 5707.857303567413, 5752.223449834271, 5819.4471525205145, 5711.143328500727, 5778.162166485857, 5798.275215598051, 5816.680082595455, 5849.9707501462535, 4357.825686972526, 4357.847475338363, 4359.433273674418, 4365.497967733703, 4370.38814565961, 4148.668106551469, 4257.084726783741, 4257.8296868125235, 4266.7439953602725, 4351.934720979188, 4263.360495925605, 4282.100758840632, 4292.18448494785, 4296.441462609856, 4311.784410779464, 4131.235721391552, 4293.785310734466, 4299.935500967488, 4305.526392096866, 4308.31067029277, 3559.18138828071, 3587.0852932502307, 3628.256207477461, 3628.872989445357, 3648.2885837261742, 5509.614326997112, 5530.087535556629, 5534.916976245359, 5554.389017208104, 5574.58190635704, 4854.320395144682, 4864.294677271776, 4870.391201099863, 4876.731779752112, 4884.902301953976, 5777.88444231113, 5995.070764031582, 6003.549733769941, 6006.609570377911, 6007.279126504804, 3974.423708562242, 3995.161016186575, 3999.0402303447254, 4003.259397011533, 4008.599140085997, 6222.782202622887, 6329.2721337045905, 6335.04974253861, 6342.80971570849, 6344.175257216532, 4020.2160578686876, 4027.275090483741, 4035.233305671913, 4039.434479172918, 4057.0263136846943, 3965.9603403966166, 4065.0243941453837, 4076.796160192038, 4085.8569950051606, 4090.550039495653, 4833.685810422311, 4841.95158048422, 4844.394450693663, 4852.398708426211, 4856.854294371175, 6027.095935609606, 6032.034874420072, 6032.426919442646, 6036.275646922398, 6047.244094488189, 1383.9100458470168, 1446.5515690136092, 1447.4282658349894, 1450.8549145085408, 1451.8620731030535, 916.9908300917039, 924.3806649544821, 929.1544694328264, 935.4808081514689, 948.3977674176809, 5750.539956803445, 5774.682392468455, 5789.565782566325, 5802.303723553201, 5823.679697616587, 6274.717637706223, 6282.0, 6288.591241569284, 6294.653794041372, 6319.462845658079, 5732.942670573324, 5754.136879468029, 5761.9135712964335, 5784.59507834456, 5786.132080188006, 3276.819774912355, 3310.8344582770765, 3346.6151392590164, 3363.24327026422, 3413.6586341365664, 6359.427651511386, 6514.57655252407, 6556.442702370352, 6569.178852643419, 6574.539782215199, 6526.771562995367, 6532.412082912466, 6534.934650653528, 6538.509611779135, 6545.705443255065, 6329.968350158312, 6542.476601871839, 6561.671916404256, 6567.113439685677, 6572.638504882278, 6340.239171299289, 6351.555391122577, 6355.88771964895, 6359.0, 6367.458766004941, 6199.752009919553, 6212.192414986023, 6235.75056997715, 6240.906386404116, 6249.96875015622, 6295.401936815995, 6501.934980650322, 6518.641474718936, 6552.934470655423, 6561.245456772533, 4054.1283624020975, 4092.3656833190903, 4093.263212621757, 4096.508418989741, 4110.712250142461, 6283.151774510383, 6307.148534947723, 6333.303336633059, 6342.90485642725, 6344.0, 6137.723802428991, 6158.784442544489, 6158.907616385847, 6174.66039367839, 6194.38056194377, 5856.9121463178935, 6004.579679422399, 6029.366916473882, 6037.69811509414, 6119.785807496716, 5955.612885162624, 5982.730777115127, 5998.70006499682, 5999.52003839683, 6001.06983417571, 6093.0, 6100.389961003864, 6115.327313995368, 6117.602355846856, 6124.0, 5858.736356863866, 5931.1992880960515, 6024.33732289439, 6034.064719968412, 6048.153258543895], "yui.html": [665.693780860804, 667.3060017581715, 675.8276639456938, 679.5175425447932, 694.600604652325, 12345.938270308647, 12376.752464950696, 12631.178973366736, 12638.557650482235, 12665.873341266608, 11770.352630605314, 11787.233829801078, 11806.822897656542, 11832.7633447331, 11868.406579671004, 644.0564572900699, 659.3340725866861, 797.2107613462674, 811.5820352518458, 818.9344852411823, 797.366093955307, 799.3205775091184, 809.7327881798992, 811.4684881402661, 813.2274339377615, 822.8436597046542, 823.9093699693029, 830.3025458614762, 835.064727505195, 835.3651225068961, 655.8589903170817, 670.0485310858593, 821.4701517521195, 829.1708291708292, 843.228445971941, 623.7847942459844, 625.2809269340249, 627.42903957399, 628.7736414890636, 633.8732253549263, 12262.570810021607, 12418.81371779424, 12477.438515266744, 12478.251304921734, 12490.43793029316, 10049.145822605087, 10155.492225388702, 10443.0, 10711.464426778708, 10778.838317425245, 8390.538520381377, 8416.452930559493, 8519.557254498815, 8577.699780507652, 8671.56642167889, 3016.8642411091555, 3040.665526792051, 3056.0984509569507, 3061.800982936102, 3070.125014370916, 44325.0, 44456.77771611154, 44646.33030504545, 45078.77460612676, 45299.09401811945, 8180.754577362689, 8249.0, 8256.25693687571, 8290.709825156091, 8308.459950103224, 17760.37838675666, 17778.0, 17792.55518612045, 17795.288188472317, 17821.7326740099, 5661.547076233891, 6493.415592596689, 6496.610203387811, 6527.445167160749, 6703.3296670332575, 3576.7317451191266, 3622.7464077514846, 3716.3124821907495, 3723.069232691827, 3744.8876533704033, 2399.5560821248123, 2419.806415486757, 2421.3099266708905, 2423.0, 2429.8177636676965, 359.55774397491234, 359.572109190063, 363.91266096136735, 367.83631284078865, 370.7793862651718, 469.72051629280526, 471.5590922487485, 507.1986261706495, 520.5939367293518, 576.6770608459192, 6769.42459890905, 7193.604351760599, 7263.2736726328, 7467.327940485274, 7534.811629709301, 517.6893863681836, 531.0865311663932, 542.9104197807318, 564.8249042796746, 565.2849145830528, 3383.881564145243, 3402.3535528249554, 3512.5433693619666, 3698.4637227602384, 3836.854098050707, 53252.733736331844, 53364.0, 53596.464035359924, 53884.191737123976, 54436.727816361454, 45003.0, 45748.3137752934, 46105.538944610125, 46136.5386346139, 46676.7666161667, 41905.58094419078, 41924.16151676949, 42300.0, 42432.0, 43022.0, 7402.333789958714, 7430.368418684472, 7438.0, 7670.8849367260655, 7742.883856742266, 29911.102666920026, 30609.387812244076, 30761.230969225948, 31664.0, 32152.0, 39941.60058399495, 42226.25529340583, 42237.31050757935, 42804.35793463038, 43170.784146079066, 6701.463882889455, 6757.932420675927, 6979.930200698132, 7054.6472676367, 7127.786166415016, 9909.157721593458, 9923.092289252781, 9961.701148965543, 9985.439763855748, 10058.346207496783, 9363.250939924654, 9364.391314564531, 9404.623815047322, 9409.576569054547, 9418.81162376735, 9449.102335278138, 9450.858237126586, 9549.618015279311, 9550.331476796835, 9562.569684364082, 9377.109174628673, 9419.764505887408, 9430.434173949585, 9466.857997129911, 9486.810263794547, 8044.919550804651, 8160.591970401338, 8566.314694824523, 8644.56777161152, 8740.388172828096, 8067.552519487395, 8260.0, 8424.873626895478, 8429.114942930904, 8577.571121443778]}, "summary": {"lowerIsBetter": false, "suite": 6025.096926329428, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5928.673127450797, "unit": "ms", "value": 5928.673127450797}, "dojo.html": {"lowerIsBetter": false, "filtered": 4852.348635193519, "unit": "ms", "value": 4852.348635193519}, "mootools.html": {"lowerIsBetter": false, "filtered": 4140.0404939064965, "unit": "ms", "value": 4140.0404939064965}, "ext.html": {"lowerIsBetter": false, "filtered": 16370.219207678096, "unit": "ms", "value": 16370.219207678096}, "prototype.html": {"lowerIsBetter": false, "filtered": 4497.882503362338, "unit": "ms", "value": 4497.882503362338}, "yui.html": {"lowerIsBetter": false, "filtered": 5454.684930776797, "unit": "ms", "value": 5454.684930776797}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0026"}, "testrun": {"date": 1447723084, "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": "20151116145334", "branch": "Fx-Team", "revision": "3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33"}}, {"talos_counters": {}, "results": {"audio-dft": [173.0, 180.0, 181.0, 180.0, 175.0, 182.0, 179.0, 178.0, 172.0, 209.0], "ai-astar": [110.0, 109.0, 110.0, 111.0, 110.0, 116.0, 109.0, 111.0, 106.0, 112.0], "imaging-gaussian-blur": [135.0, 135.0, 129.0, 135.0, 134.0, 136.0, 135.0, 129.0, 129.0, 135.0], "audio-beat-detection": [175.0, 147.0, 173.0, 188.0, 144.0, 169.0, 166.0, 141.0, 183.0, 143.0], "json-stringify-tinderbox": [71.0, 73.0, 76.0, 78.0, 77.0, 77.0, 78.0, 77.0, 86.0, 78.0], "stanford-crypto-pbkdf2": [157.0, 179.0, 162.0, 171.0, 173.0, 159.0, 176.0, 173.0, 174.0, 160.0], "json-parse-financial": [63.0, 63.0, 63.0, 65.0, 66.0, 66.0, 65.0, 75.0, 65.0, 65.0], "stanford-crypto-sha256-iterative": [74.0, 77.0, 80.0, 80.0, 79.0, 78.0, 82.0, 81.0, 82.0, 79.0], "audio-fft": [77.0, 90.0, 101.0, 96.0, 76.0, 78.0, 80.0, 92.0, 97.0, 79.0], "imaging-darkroom": [141.0, 142.0, 142.0, 141.0, 141.0, 141.0, 141.0, 147.0, 142.0, 141.0], "stanford-crypto-ccm": [139.0, 155.0, 152.0, 143.0, 154.0, 135.0, 149.0, 145.0, 145.0, 145.0], "audio-oscillator": [106.0, 110.0, 151.0, 98.0, 100.0, 100.0, 139.0, 99.0, 98.0, 144.0], "stanford-crypto-aes": [95.0, 95.0, 98.0, 100.0, 98.0, 96.0, 97.0, 97.0, 98.0, 97.0], "imaging-desaturate": [113.0, 106.0, 109.0, 116.0, 105.0, 113.0, 118.0, 117.0, 105.0, 104.0]}, "summary": {"lowerIsBetter": true, "suite": 1674.6, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 86.6, "unit": "ms", "value": 86.6}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 168.4, "unit": "ms", "value": 168.4}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 162.9, "unit": "ms", "value": 162.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 146.2, "unit": "ms", "value": 146.2}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 141.9, "unit": "ms", "value": 141.9}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 65.6, "unit": "ms", "value": 65.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 114.5, "unit": "ms", "value": 114.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 110.4, "unit": "ms", "value": 110.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 180.9, "unit": "ms", "value": 180.9}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 79.2, "unit": "ms", "value": 79.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 77.1, "unit": "ms", "value": 77.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 133.2, "unit": "ms", "value": 133.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 97.1, "unit": "ms", "value": 97.1}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 110.6, "unit": "ms", "value": 110.6}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0026"}, "testrun": {"date": 1447723084, "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": "20151116145334", "branch": "Fx-Team", "revision": "3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33"}}, {"talos_counters": {}, "results": {"DeltaBlue": [226.70596236681024], "Encrypt": [357.27045373347624], "NavierStokes": [6416.666666666667], "Decrypt": [6369.426751592357], "Splay": [826.4462809917355], "Richards": [174.85574401119078], "RegExp": [32596.774193548386], "Earley": [1014.1987829614604], "Boyer": [14579.710144927536], "RayTrace": [2102.9411764705883]}, "summary": {"lowerIsBetter": false, "suite": 16264.273673507882, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 291.64649800000007, "unit": "score", "value": 291.64649800000007}, "Encrypt": {"lowerIsBetter": false, "filtered": 745.0406189999999, "unit": "score", "value": 745.0406189999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 231.2727272727272, "unit": "score", "value": 231.2727272727272}, "Decrypt": {"lowerIsBetter": false, "filtered": 41.79041699999997, "unit": "score", "value": 41.79041699999997}, "Splay": {"lowerIsBetter": false, "filtered": 98.60410999999999, "unit": "score", "value": 98.60410999999999}, "RegExp": {"lowerIsBetter": false, "filtered": 27.947090549233046, "unit": "score", "value": 27.947090549233046}, "Richards": {"lowerIsBetter": false, "filtered": 201.89213799999996, "unit": "score", "value": 201.89213799999996}, "Earley": {"lowerIsBetter": false, "filtered": 657.1325180000003, "unit": "score", "value": 657.1325180000003}, "Boyer": {"lowerIsBetter": false, "filtered": 45.71167693836978, "unit": "score", "value": 45.71167693836978}, "RayTrace": {"lowerIsBetter": false, "filtered": 351.88288111888113, "unit": "score", "value": 351.88288111888113}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0026"}, "testrun": {"date": 1447723084, "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": "20151116145334", "branch": "Fx-Team", "revision": "3dcb690e49f2ea194dd46aba99ddd2f7fde1ba33"}}] 17:38:20 INFO - RETURN: dromaeo_css: 6025.10 17:38:20 INFO - RETURN: kraken: 1674.60 17:38:20 INFO - RETURN: v8_7: 16264.27 17:38:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "16264.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1674.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6025.10"}}} 17:38:20 INFO - Return code: 0 17:38:20 INFO - # TBPL SUCCESS # 17:38:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:38:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:38:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:38:20 INFO - 2015-11-16 17:38:20.380 screenresolution[1970:23027] starting screenresolution argv=screenresolution get 17:38:20 INFO - 2015-11-16 17:38:20.383 screenresolution[1970:23027] Display 0: 1600x1200x32@60 17:38:20 INFO - 2015-11-16 17:38:20.389 screenresolution[1971:23030] starting screenresolution argv=screenresolution list 17:38:20 INFO - Available Modes on Display 0 17:38:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:38:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:38:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:38:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:38:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:38:20 INFO - Intel HD Graphics 3000: 17:38:20 INFO - Chipset Model: Intel HD Graphics 3000 17:38:20 INFO - Type: GPU 17:38:20 INFO - Bus: Built-In 17:38:20 INFO - VRAM (Total): 512 MB 17:38:20 INFO - VRAM (Dynamic, Max): 10 17:38:20 INFO - Vendor: Intel (0x8086) 17:38:20 INFO - Device ID: 0x0116 17:38:20 INFO - Revision ID: 0x0009 17:38:20 INFO - Displays: 17:38:20 INFO - Display: 17:38:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:38:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:38:20 INFO - Display Serial Number: 1600x1200 60 17:38:20 INFO - Main Display: Yes 17:38:20 INFO - Mirror: Off 17:38:20 INFO - Online: Yes 17:38:20 INFO - Rotation: Supported 17:38:20 INFO - Return code: 0 17:38:20 INFO - Running post-action listener: _resource_record_post_action 17:38:20 INFO - Running post-run listener: _resource_record_post_run 17:38:21 INFO - Total resource usage - Wall time: 1256s; CPU: 30.0%; Read bytes: 2658304; Write bytes: 688132096; Read time: 1313; Write time: 52907 17:38:21 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 338610688; Write bytes: 337367040; Read time: 34341; Write time: 5744 17:38:21 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 2654208; Write bytes: 339566592; Read time: 1289; Write time: 46599 17:38:21 INFO - Running post-run listener: _upload_blobber_files 17:38:21 INFO - Blob upload gear active. 17:38:21 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:38:21 INFO - Copying logs to upload dir... 17:38:21 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1307.822632 ========= master_lag: 2.55 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 50 secs) (at 2015-11-16 17:38:24.317565) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 17:38:24.323019) ========= 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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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/bVkPjTuiTxCpkDsNtNx3BQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010336 build_url: 'https://queue.taskcluster.net/v1/task/bVkPjTuiTxCpkDsNtNx3BQ/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-16 17:38:24.352904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:38:24.353221) ========= 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.N9WOJVQ63p/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.TbrtN6QL5U/Listeners TMPDIR=/var/folders/m5/zc0lkkz12394_ccx53jm1n8c00000w/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.005320 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 17:38:24.402273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 17:38:24.402573) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 17:38:24.402955) ========= ========= Total master_lag: 2.75 =========