builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0054 starttime: 1447828464.25 results: success (0) buildid: 20151117210240 builduid: a961968edfd04d2ca7ed25d1fdb44817 revision: fb5b48c3abe6dc120cde93464372d2bf9095a7a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.246136) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.246507) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.246790) ========= 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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.006321 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.328055) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.328348) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.432815) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.433068) ========= 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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.013194 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.484018) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.484282) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.484658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.484932) ========= 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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-17 22:34:24-- 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% 39.7M=0s 2015-11-17 22:34:24 (39.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217863 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.722105) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.722405) ========= 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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.126591 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.867280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:24.868146) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fb5b48c3abe6dc120cde93464372d2bf9095a7a2 --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 fb5b48c3abe6dc120cde93464372d2bf9095a7a2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-17 22:34:24,975 truncating revision to first 12 chars 2015-11-17 22:34:24,975 Setting DEBUG logging. 2015-11-17 22:34:24,975 attempt 1/10 2015-11-17 22:34:24,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fb5b48c3abe6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 22:34:25,235 unpacking tar archive at: fx-team-fb5b48c3abe6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549402 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:25.438142) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:25.441566) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:25.465211) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:25.468592) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 22:34:25.469042) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 18 secs) (at 2015-11-17 22:34:25.469412) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 22:34:25 INFO - MultiFileLogger online at 20151117 22:34:25 in /builds/slave/test 22:34:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:34:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:34:25 INFO - {'append_to_log': False, 22:34:25 INFO - 'base_work_dir': '/builds/slave/test', 22:34:25 INFO - 'blob_upload_branch': 'Fx-Team', 22:34:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:34:25 INFO - 'branch': 'Fx-Team', 22:34:25 INFO - 'buildbot_json_path': 'buildprops.json', 22:34:25 INFO - 'config_files': ('talos/mac_config.py',), 22:34:25 INFO - 'default_actions': ('clobber', 22:34:25 INFO - 'read-buildbot-config', 22:34:25 INFO - 'download-and-extract', 22:34:25 INFO - 'populate-webroot', 22:34:25 INFO - 'create-virtualenv', 22:34:25 INFO - 'install', 22:34:25 INFO - 'run-tests'), 22:34:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:34:25 INFO - 'download_minidump_stackwalk': True, 22:34:25 INFO - 'download_symbols': 'ondemand', 22:34:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:34:25 INFO - 'tooltool.py': '/tools/tooltool.py', 22:34:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:34:25 INFO - '/tools/misc-python/virtualenv.py')}, 22:34:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:34:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:34:25 INFO - 'installer_path': 'installer.exe', 22:34:25 INFO - 'log_level': 'info', 22:34:25 INFO - 'log_name': 'talos', 22:34:25 INFO - 'log_to_console': True, 22:34:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:34:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:34:25 INFO - 'opt_config_files': (), 22:34:25 INFO - 'pip_index': False, 22:34:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:34:25 INFO - 'cmd': ('bash', 22:34:25 INFO - '-c', 22:34:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:34:25 INFO - 'enabled': True, 22:34:25 INFO - 'halt_on_failure': False, 22:34:25 INFO - 'name': 'check_screen_resolution'},), 22:34:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:34:25 INFO - 'cmd': ('bash', 22:34:25 INFO - '-c', 22:34:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:34:25 INFO - 'enabled': True, 22:34:25 INFO - 'halt_on_failure': False, 22:34:25 INFO - 'name': 'check_screen_resolution'},), 22:34:25 INFO - 'run_cmd_checks_enabled': True, 22:34:25 INFO - 'sps_profile': False, 22:34:25 INFO - 'sps_profile_interval': 0, 22:34:25 INFO - 'suite': 'dromaeojs-e10s', 22:34:25 INFO - 'system_bits': '64', 22:34:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:34:25 INFO - 'title': 't-yosemite-r5-0054', 22:34:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:34:25 INFO - 'use_talos_json': True, 22:34:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:34:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:34:25 INFO - 'work_dir': 'build'} 22:34:25 INFO - ##### 22:34:25 INFO - ##### Running clobber step. 22:34:25 INFO - ##### 22:34:25 INFO - Running pre-action listener: _resource_record_pre_action 22:34:25 INFO - Running main action method: clobber 22:34:25 INFO - rmtree: /builds/slave/test/build 22:34:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:34:29 INFO - Running post-action listener: _resource_record_post_action 22:34:29 INFO - ##### 22:34:29 INFO - ##### Running read-buildbot-config step. 22:34:29 INFO - ##### 22:34:29 INFO - Running pre-action listener: _resource_record_pre_action 22:34:29 INFO - Running main action method: read_buildbot_config 22:34:29 INFO - Using buildbot properties: 22:34:29 INFO - { 22:34:29 INFO - "properties": { 22:34:29 INFO - "buildnumber": 54, 22:34:29 INFO - "product": "firefox", 22:34:29 INFO - "script_repo_revision": "production", 22:34:29 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 22:34:29 INFO - "repository": "", 22:34:29 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 22:34:29 INFO - "buildid": "20151117210240", 22:34:29 INFO - "slavename": "t-yosemite-r5-0054", 22:34:29 INFO - "pgo_build": "False", 22:34:29 INFO - "basedir": "/builds/slave/test", 22:34:29 INFO - "project": "", 22:34:29 INFO - "platform": "yosemite", 22:34:29 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 22:34:29 INFO - "slavebuilddir": "test", 22:34:29 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:34:29 INFO - "branch": "fx-team", 22:34:29 INFO - "repo_path": "integration/fx-team", 22:34:29 INFO - "stage_platform": "macosx64", 22:34:29 INFO - "builduid": "a961968edfd04d2ca7ed25d1fdb44817", 22:34:29 INFO - "revision": "fb5b48c3abe6dc120cde93464372d2bf9095a7a2" 22:34:29 INFO - }, 22:34:29 INFO - "sourcestamp": { 22:34:29 INFO - "repository": "", 22:34:29 INFO - "hasPatch": false, 22:34:29 INFO - "project": "", 22:34:29 INFO - "branch": "fx-team-macosx64-talos", 22:34:29 INFO - "changes": [ 22:34:29 INFO - { 22:34:29 INFO - "category": null, 22:34:29 INFO - "files": [ 22:34:29 INFO - { 22:34:29 INFO - "url": null, 22:34:29 INFO - "name": "https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 22:34:29 INFO - } 22:34:29 INFO - ], 22:34:29 INFO - "repository": "", 22:34:29 INFO - "rev": "fb5b48c3abe6dc120cde93464372d2bf9095a7a2", 22:34:29 INFO - "who": "philringnalda@gmail.com", 22:34:29 INFO - "when": 1447828412, 22:34:29 INFO - "number": 6676177, 22:34:29 INFO - "comments": "Bug 1166297 - As a last resort, use requestLongerTimeout() in browser_tabMatchesInAwesomebar.js", 22:34:29 INFO - "project": "", 22:34:29 INFO - "at": "Tue 17 Nov 2015 22:33:32", 22:34:29 INFO - "branch": "fx-team-macosx64-talos", 22:34:29 INFO - "revlink": "", 22:34:29 INFO - "properties": [ 22:34:29 INFO - [ 22:34:29 INFO - "buildid", 22:34:29 INFO - "20151117210240", 22:34:29 INFO - "Change" 22:34:29 INFO - ], 22:34:29 INFO - [ 22:34:29 INFO - "builduid", 22:34:29 INFO - "a961968edfd04d2ca7ed25d1fdb44817", 22:34:29 INFO - "Change" 22:34:29 INFO - ], 22:34:29 INFO - [ 22:34:29 INFO - "pgo_build", 22:34:29 INFO - "False", 22:34:29 INFO - "Change" 22:34:29 INFO - ] 22:34:29 INFO - ], 22:34:29 INFO - "revision": "fb5b48c3abe6dc120cde93464372d2bf9095a7a2" 22:34:29 INFO - } 22:34:29 INFO - ], 22:34:29 INFO - "revision": "fb5b48c3abe6dc120cde93464372d2bf9095a7a2" 22:34:29 INFO - } 22:34:29 INFO - } 22:34:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 22:34:29 INFO - Running post-action listener: _resource_record_post_action 22:34:29 INFO - ##### 22:34:29 INFO - ##### Running download-and-extract step. 22:34:29 INFO - ##### 22:34:29 INFO - Running pre-action listener: _resource_record_pre_action 22:34:29 INFO - Running main action method: download_and_extract 22:34:29 INFO - mkdir: /builds/slave/test/build/tests 22:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:34:29 INFO - https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:34:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/test_packages.json 22:34:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/test_packages.json 22:34:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:34:41 INFO - Downloaded 1149 bytes. 22:34:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:34:41 INFO - Using the following test package requirements: 22:34:41 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:34:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:34:41 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 22:34:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:34:41 INFO - u'jsshell-mac.zip'], 22:34:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:34:41 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 22:34:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:34:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:34:41 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 22:34:41 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:34:41 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 22:34:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:34:41 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 22:34:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:34:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:34:41 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 22:34:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:34:41 INFO - https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:34:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:34:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:34:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:34:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:34:48 INFO - Downloaded 17463490 bytes. 22:34:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 22:34:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:34:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:34:55 INFO - Return code: 0 22:34:55 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 22:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:34:55 INFO - https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:34:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:34:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:34:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 22:34:57 INFO - Downloaded 17463490 bytes. 22:34:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 22:34:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:34:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:35:04 INFO - Return code: 0 22:35: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')]} 22:35:04 INFO - https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:35:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:35:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:35:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:35:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 22:35:05 INFO - Downloaded 11131693 bytes. 22:35:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 22:35:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:35:05 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 22:35:06 INFO - Return code: 0 22:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:06 INFO - https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:35:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:35:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:35:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 22:35:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 22:35:10 INFO - Downloaded 108847050 bytes. 22:35:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:35:10 INFO - mkdir: /builds/slave/test/properties 22:35:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:35:10 INFO - Writing to file /builds/slave/test/properties/build_url 22:35:10 INFO - Contents: 22:35:10 INFO - build_url:https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:35:10 INFO - Running post-action listener: _resource_record_post_action 22:35:10 INFO - Running post-action listener: set_extra_try_arguments 22:35:10 INFO - ##### 22:35:10 INFO - ##### Running populate-webroot step. 22:35:10 INFO - ##### 22:35:10 INFO - Running pre-action listener: _resource_record_pre_action 22:35:10 INFO - Running main action method: populate_webroot 22:35:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:35:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:35:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:35:10 INFO - '../fennec_ids.txt'], 22:35:10 INFO - 'tests': ['tcheck2']}, 22:35:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:35:10 INFO - '--tppagecycles', 22:35:10 INFO - '7'], 22:35:10 INFO - 'tests': ['tsvgm']}}, 22:35:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:35:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:35:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:35:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:35:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:35:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:35:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:35:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:10 INFO - 'talos_options': ['--e10s'], 22:35:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:35:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:10 INFO - 'tests': ['damp', 'tps']}, 22:35:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:10 INFO - 'talos_options': ['--e10s'], 22:35:10 INFO - 'tests': ['damp', 'tps']}, 22:35:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:35:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:35:10 INFO - 'other': {'tests': ['a11yr', 22:35:10 INFO - 'ts_paint', 22:35:10 INFO - 'tpaint', 22:35:10 INFO - 'sessionrestore', 22:35:10 INFO - 'sessionrestore_no_auto_restore']}, 22:35:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:35:10 INFO - 'tests': ['a11yr', 22:35:10 INFO - 'ts_paint', 22:35:10 INFO - 'tpaint', 22:35:10 INFO - 'sessionrestore', 22:35:10 INFO - 'sessionrestore_no_auto_restore']}, 22:35:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:35:10 INFO - 'tests': ['a11yr', 22:35:10 INFO - 'ts_paint', 22:35:10 INFO - 'tpaint', 22:35:10 INFO - 'sessionrestore', 22:35:10 INFO - 'sessionrestore_no_auto_restore']}, 22:35:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:35:10 INFO - 'tests': ['a11yr', 22:35:10 INFO - 'ts_paint', 22:35:10 INFO - 'tpaint', 22:35:10 INFO - 'sessionrestore', 22:35:10 INFO - 'sessionrestore_no_auto_restore']}, 22:35:10 INFO - 'other_l64': {'tests': ['a11yr', 22:35:10 INFO - 'ts_paint', 22:35:10 INFO - 'tpaint', 22:35:10 INFO - 'sessionrestore', 22:35:10 INFO - 'sessionrestore_no_auto_restore']}, 22:35:10 INFO - 'other_nol64': {'tests': ['a11yr', 22:35:10 INFO - 'ts_paint', 22:35:10 INFO - 'tpaint', 22:35:10 INFO - 'sessionrestore', 22:35:10 INFO - 'sessionrestore_no_auto_restore']}, 22:35:10 INFO - 'svgr': {'tests': ['tsvgx', 22:35:10 INFO - 'tsvgr_opacity', 22:35:10 INFO - 'tart', 22:35:10 INFO - 'tscrollx', 22:35:10 INFO - 'cart']}, 22:35:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:35:10 INFO - 'tests': ['tsvgx', 22:35:10 INFO - 'tsvgr_opacity', 22:35:10 INFO - 'tart', 22:35:10 INFO - 'tscrollx', 22:35:10 INFO - 'cart']}, 22:35:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:10 INFO - 'tests': ['tp5o']}, 22:35:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:10 INFO - 'talos_options': ['--e10s'], 22:35:10 INFO - 'tests': ['tp5o']}, 22:35:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:10 INFO - 'talos_options': ['--xperf_path', 22:35:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:35:10 INFO - 'tests': ['tp5n']}, 22:35:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:35:10 INFO - 'talos_options': ['--e10s', 22:35:10 INFO - '--xperf_path', 22:35:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:35:10 INFO - 'tests': ['tp5n']}}, 22:35:10 INFO - 'talos.zip': {'path': '', 22:35:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:35:10 INFO - Running post-action listener: _resource_record_post_action 22:35:10 INFO - ##### 22:35:10 INFO - ##### Running create-virtualenv step. 22:35:10 INFO - ##### 22:35:10 INFO - Running pre-action listener: _resource_record_pre_action 22:35:10 INFO - Running main action method: create_virtualenv 22:35:10 INFO - Creating virtualenv /builds/slave/test/build/venv 22:35:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:35:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:35:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:35:10 INFO - Using real prefix '/tools/python27' 22:35:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:35:11 INFO - Installing distribute.............................................................................................................................................................................................done. 22:35:15 INFO - Installing pip.................done. 22:35:15 INFO - Return code: 0 22:35:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8504120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10700b9f0>, '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 0x106d6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fff8c8>, '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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ThcP4JkU9D/Render', 22:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:35:15 INFO - 'HOME': '/Users/cltbld', 22:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:35:15 INFO - 'LOGNAME': 'cltbld', 22:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:15 INFO - 'MOZ_NO_REMOTE': '1', 22:35:15 INFO - 'NO_EM_RESTART': '1', 22:35:15 INFO - 'PAGER': '/bin/cat', 22:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:15 INFO - 'PWD': '/builds/slave/test', 22:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:35:15 INFO - 'SHELL': '/bin/bash', 22:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyR1rv4Mkq/Listeners', 22:35:15 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 22:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:35:15 INFO - 'USER': 'cltbld', 22:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:15 INFO - 'XPC_FLAGS': '0x0', 22:35:15 INFO - 'XPC_SERVICE_NAME': '0', 22:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:35:16 INFO - Cleaning up... 22:35:16 INFO - Return code: 0 22:35:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:16 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 0x1070e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8504120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10700b9f0>, '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 0x106d6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fff8c8>, '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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:35:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:35:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ThcP4JkU9D/Render', 22:35:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:35:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:35:16 INFO - 'HOME': '/Users/cltbld', 22:35:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:35:16 INFO - 'LOGNAME': 'cltbld', 22:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:16 INFO - 'MOZ_NO_REMOTE': '1', 22:35:16 INFO - 'NO_EM_RESTART': '1', 22:35:16 INFO - 'PAGER': '/bin/cat', 22:35:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:16 INFO - 'PWD': '/builds/slave/test', 22:35:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:35:16 INFO - 'SHELL': '/bin/bash', 22:35:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyR1rv4Mkq/Listeners', 22:35:16 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 22:35:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:35:16 INFO - 'USER': 'cltbld', 22:35:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:35:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:16 INFO - 'XPC_FLAGS': '0x0', 22:35:16 INFO - 'XPC_SERVICE_NAME': '0', 22:35:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:16 INFO - Downloading/unpacking psutil>=0.7.1 22:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:19 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:35:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:35:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:35:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:35:19 INFO - Installing collected packages: psutil 22:35:19 INFO - Running setup.py install for psutil 22:35:19 INFO - building 'psutil._psutil_osx' extension 22:35:19 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 22:35:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 22:35:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 22:35:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 22:35:22 INFO - building 'psutil._psutil_posix' extension 22:35:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 22:35:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:35:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:35:22 INFO - ^ 22:35:22 INFO - 1 warning generated. 22:35:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 22:35:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:35:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:35:22 INFO - Successfully installed psutil 22:35:22 INFO - Cleaning up... 22:35:22 INFO - Return code: 0 22:35:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:22 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 0x1070e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8504120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10700b9f0>, '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 0x106d6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fff8c8>, '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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:35:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:35:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ThcP4JkU9D/Render', 22:35:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:35:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:35:22 INFO - 'HOME': '/Users/cltbld', 22:35:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:35:22 INFO - 'LOGNAME': 'cltbld', 22:35:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:22 INFO - 'MOZ_NO_REMOTE': '1', 22:35:22 INFO - 'NO_EM_RESTART': '1', 22:35:22 INFO - 'PAGER': '/bin/cat', 22:35:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:35:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:22 INFO - 'PWD': '/builds/slave/test', 22:35:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:35:22 INFO - 'SHELL': '/bin/bash', 22:35:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyR1rv4Mkq/Listeners', 22:35:22 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 22:35:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:35:22 INFO - 'USER': 'cltbld', 22:35:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:35:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:35:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:22 INFO - 'XPC_FLAGS': '0x0', 22:35:22 INFO - 'XPC_SERVICE_NAME': '0', 22:35:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:35:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:35:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:35:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:35:25 INFO - Installing collected packages: mozsystemmonitor 22:35:25 INFO - Running setup.py install for mozsystemmonitor 22:35:25 INFO - Successfully installed mozsystemmonitor 22:35:25 INFO - Cleaning up... 22:35:25 INFO - Return code: 0 22:35:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:25 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 0x1070e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8504120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10700b9f0>, '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 0x106d6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fff8c8>, '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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:35:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ThcP4JkU9D/Render', 22:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:35:25 INFO - 'HOME': '/Users/cltbld', 22:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:35:25 INFO - 'LOGNAME': 'cltbld', 22:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:25 INFO - 'MOZ_NO_REMOTE': '1', 22:35:25 INFO - 'NO_EM_RESTART': '1', 22:35:25 INFO - 'PAGER': '/bin/cat', 22:35:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:25 INFO - 'PWD': '/builds/slave/test', 22:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:35:25 INFO - 'SHELL': '/bin/bash', 22:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyR1rv4Mkq/Listeners', 22:35:25 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 22:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:35:25 INFO - 'USER': 'cltbld', 22:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:25 INFO - 'XPC_FLAGS': '0x0', 22:35:25 INFO - 'XPC_SERVICE_NAME': '0', 22:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:26 INFO - Downloading/unpacking blobuploader==1.2.4 22:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:28 INFO - Downloading blobuploader-1.2.4.tar.gz 22:35:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:35:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:35:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:30 INFO - Downloading docopt-0.6.1.tar.gz 22:35:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:35:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:35:30 INFO - Installing collected packages: blobuploader, requests, docopt 22:35:30 INFO - Running setup.py install for blobuploader 22:35:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:35:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:35:30 INFO - Running setup.py install for requests 22:35:31 INFO - Running setup.py install for docopt 22:35:31 INFO - Successfully installed blobuploader requests docopt 22:35:31 INFO - Cleaning up... 22:35:31 INFO - Return code: 0 22:35:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:31 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 0x1070e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8504120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10700b9f0>, '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 0x106d6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fff8c8>, '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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:35:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:35:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ThcP4JkU9D/Render', 22:35:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:35:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:35:31 INFO - 'HOME': '/Users/cltbld', 22:35:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:35:31 INFO - 'LOGNAME': 'cltbld', 22:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:31 INFO - 'MOZ_NO_REMOTE': '1', 22:35:31 INFO - 'NO_EM_RESTART': '1', 22:35:31 INFO - 'PAGER': '/bin/cat', 22:35:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:31 INFO - 'PWD': '/builds/slave/test', 22:35:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:35:31 INFO - 'SHELL': '/bin/bash', 22:35:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyR1rv4Mkq/Listeners', 22:35:31 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 22:35:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:35:31 INFO - 'USER': 'cltbld', 22:35:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:35:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:31 INFO - 'XPC_FLAGS': '0x0', 22:35:31 INFO - 'XPC_SERVICE_NAME': '0', 22:35:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:35:31 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-CViZ3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:35:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:35:31 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-iNLJJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:35:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-UVmgsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:35:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-rHkEUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:35:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-57hFVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:35:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-SY3IYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:35:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-Prd82X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:35:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-bkv9rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:35:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-hIWXZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:35:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:35:32 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-7663nS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:35:33 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-AlxHka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:35:33 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-2p1sCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:35:33 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-QeHGGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:35:33 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-kcJGnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:35:33 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-xTDR1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:35:33 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-E4wLvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:35:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:35:33 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-8il_HW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:35:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:35:34 INFO - Running setup.py install for manifestparser 22:35:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:35:34 INFO - Running setup.py install for mozcrash 22:35:34 INFO - Running setup.py install for mozdebug 22:35:34 INFO - Running setup.py install for mozdevice 22:35:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:35:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:35:34 INFO - Running setup.py install for mozfile 22:35:34 INFO - Running setup.py install for mozhttpd 22:35:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:35:35 INFO - Running setup.py install for mozinfo 22:35:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:35:35 INFO - Running setup.py install for mozInstall 22:35:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:35:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:35:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:35:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:35:35 INFO - Running setup.py install for mozleak 22:35:35 INFO - Running setup.py install for mozlog 22:35:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:35:35 INFO - Running setup.py install for moznetwork 22:35:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:35:36 INFO - Running setup.py install for mozprocess 22:35:36 INFO - Running setup.py install for mozprofile 22:35:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:35:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:35:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:35:36 INFO - Running setup.py install for mozrunner 22:35:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:35:36 INFO - Running setup.py install for mozscreenshot 22:35:36 INFO - Running setup.py install for moztest 22:35:37 INFO - Running setup.py install for mozversion 22:35:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:35:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:35:37 INFO - Cleaning up... 22:35:37 INFO - Return code: 0 22:35:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:35: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')]} 22:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35: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')]} 22:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:37 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 0x1070e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8504120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10700b9f0>, '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 0x106d6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fff8c8>, '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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:35:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:35:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ThcP4JkU9D/Render', 22:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:35:37 INFO - 'HOME': '/Users/cltbld', 22:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:35:37 INFO - 'LOGNAME': 'cltbld', 22:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:37 INFO - 'MOZ_NO_REMOTE': '1', 22:35:37 INFO - 'NO_EM_RESTART': '1', 22:35:37 INFO - 'PAGER': '/bin/cat', 22:35:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:37 INFO - 'PWD': '/builds/slave/test', 22:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:35:37 INFO - 'SHELL': '/bin/bash', 22:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyR1rv4Mkq/Listeners', 22:35:37 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 22:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:35:37 INFO - 'USER': 'cltbld', 22:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:37 INFO - 'XPC_FLAGS': '0x0', 22:35:37 INFO - 'XPC_SERVICE_NAME': '0', 22:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:35:37 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-GjWZy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:35:37 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-lDUXX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:35:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:35:37 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-DnI9WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:35:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-_Bm6Hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:35:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-UBYoR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:35:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-PjjUeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:35:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-yOYwIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:35:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-fyFNHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:35:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-_FQJ5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:35:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-cGvaBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:35:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:35:38 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-KguegM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:35:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-39BIaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:35:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-AbDeco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:35:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-cKGmN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:35:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-g6a9fX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:35:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-a0bGMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:35:39 INFO - Running setup.py (path:/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/pip-vwFADf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:35:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:35:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:35:42 INFO - Downloading blessings-1.5.1.tar.gz 22:35:42 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:35:43 INFO - Installing collected packages: blessings 22:35:43 INFO - Running setup.py install for blessings 22:35:43 INFO - Successfully installed blessings 22:35:43 INFO - Cleaning up... 22:35:43 INFO - Return code: 0 22:35:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:35:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:35:43 INFO - Reading from file tmpfile_stdout 22:35:43 INFO - Current package versions: 22:35:43 INFO - blessings == 1.5.1 22:35:43 INFO - blobuploader == 1.2.4 22:35:43 INFO - docopt == 0.6.1 22:35:43 INFO - manifestparser == 1.1 22:35:43 INFO - mozInstall == 1.12 22:35:43 INFO - mozcrash == 0.16 22:35:43 INFO - mozdebug == 0.1 22:35:43 INFO - mozdevice == 0.47 22:35:43 INFO - mozfile == 1.2 22:35:43 INFO - mozhttpd == 0.7 22:35:43 INFO - mozinfo == 0.9 22:35:43 INFO - mozleak == 0.1 22:35:43 INFO - mozlog == 3.0 22:35:43 INFO - moznetwork == 0.27 22:35:43 INFO - mozprocess == 0.22 22:35:43 INFO - mozprofile == 0.27 22:35:43 INFO - mozrunner == 6.11 22:35:43 INFO - mozscreenshot == 0.1 22:35:43 INFO - mozsystemmonitor == 0.0 22:35:43 INFO - moztest == 0.7 22:35:43 INFO - mozversion == 1.4 22:35:43 INFO - psutil == 3.1.1 22:35:43 INFO - requests == 1.2.3 22:35:43 INFO - wsgiref == 0.1.2 22:35:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:35: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')]} 22:35:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:35:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35: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')]} 22:35:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:35:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:35:43 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 0x1070e8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070c5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd3b8504120>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10700b9f0>, '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 0x106d6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fff8c8>, '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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:35:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:35:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:35:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ThcP4JkU9D/Render', 22:35:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:35:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:35:43 INFO - 'HOME': '/Users/cltbld', 22:35:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:35:43 INFO - 'LOGNAME': 'cltbld', 22:35:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:35:43 INFO - 'MOZ_NO_REMOTE': '1', 22:35:43 INFO - 'NO_EM_RESTART': '1', 22:35:43 INFO - 'PAGER': '/bin/cat', 22:35:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:35:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:35:43 INFO - 'PWD': '/builds/slave/test', 22:35:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:35:43 INFO - 'SHELL': '/bin/bash', 22:35:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyR1rv4Mkq/Listeners', 22:35:43 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 22:35:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:35:43 INFO - 'USER': 'cltbld', 22:35:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:35:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:35:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:35:43 INFO - 'XPC_FLAGS': '0x0', 22:35:43 INFO - 'XPC_SERVICE_NAME': '0', 22:35:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:35:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:35:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:35:44 INFO - Cleaning up... 22:35:44 INFO - Return code: 0 22:35:44 INFO - Running post-action listener: _resource_record_post_action 22:35:44 INFO - Running post-action listener: _start_resource_monitoring 22:35:44 INFO - Starting resource monitoring. 22:35:44 INFO - ##### 22:35:44 INFO - ##### Running install step. 22:35:44 INFO - ##### 22:35:44 INFO - Running pre-action listener: _resource_record_pre_action 22:35:44 INFO - Running main action method: install 22:35:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:35:44 INFO - Reading from file tmpfile_stdout 22:35:44 INFO - Detecting whether we're running mozinstall >=1.0... 22:35:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:35:44 INFO - Reading from file tmpfile_stdout 22:35:44 INFO - Output received: 22:35:44 INFO - Usage: mozinstall [options] installer 22:35:44 INFO - Options: 22:35:44 INFO - -h, --help show this help message and exit 22:35:44 INFO - -d DEST, --destination=DEST 22:35:44 INFO - Directory to install application into. [default: 22:35:44 INFO - "/builds/slave/test"] 22:35:44 INFO - --app=APP Application being installed. [default: firefox] 22:35:44 INFO - mkdir: /builds/slave/test/build/application 22:35:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 22:36:25 INFO - Reading from file tmpfile_stdout 22:36:25 INFO - Output received: 22:36:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:36:25 INFO - Running post-action listener: _resource_record_post_action 22:36:25 INFO - ##### 22:36:25 INFO - ##### Running run-tests step. 22:36:25 INFO - ##### 22:36:25 INFO - Running pre-action listener: _resource_record_pre_action 22:36:25 INFO - Running main action method: run_tests 22:36:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:36:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:36:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:36:25 INFO - 2015-11-17 22:36:25.537 screenresolution[1633:9027] starting screenresolution argv=screenresolution get 22:36:25 INFO - 2015-11-17 22:36:25.541 screenresolution[1633:9027] Display 0: 1600x1200x32@60 22:36:25 INFO - 2015-11-17 22:36:25.548 screenresolution[1634:9029] starting screenresolution argv=screenresolution list 22:36:25 INFO - Available Modes on Display 0 22:36:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:36:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:36:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:36:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:36:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:36:25 INFO - Intel HD Graphics 3000: 22:36:25 INFO - Chipset Model: Intel HD Graphics 3000 22:36:25 INFO - Type: GPU 22:36:25 INFO - Bus: Built-In 22:36:25 INFO - VRAM (Total): 512 MB 22:36:25 INFO - VRAM (Dynamic, Max): 10 22:36:25 INFO - Vendor: Intel (0x8086) 22:36:25 INFO - Device ID: 0x0116 22:36:25 INFO - Revision ID: 0x0009 22:36:25 INFO - Displays: 22:36:25 INFO - Display: 22:36:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:36:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:36:25 INFO - Display Serial Number: 1600x1200 60 22:36:25 INFO - Main Display: Yes 22:36:25 INFO - Mirror: Off 22:36:25 INFO - Online: Yes 22:36:25 INFO - Rotation: Supported 22:36:25 INFO - Return code: 0 22:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:36:25 INFO - Python 2.7.3 22:36:25 INFO - Return code: 0 22:36:25 INFO - grabbing minidump binary from tooltool 22:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:36:25 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 0x10700b9f0>, '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 0x106d6bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106fff8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:36:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:36:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 22:36:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:36:25 INFO - Return code: 0 22:36:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:36:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:36:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:36:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:36:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0054', '--webServer', 'localhost'] in /builds/slave/test/build 22:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0054 --webServer localhost 22:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ThcP4JkU9D/Render', 22:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:36:25 INFO - 'HOME': '/Users/cltbld', 22:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:36:25 INFO - 'LOGNAME': 'cltbld', 22:36:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:36:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:36:25 INFO - 'MOZ_NO_REMOTE': '1', 22:36:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:36:25 INFO - 'NO_EM_RESTART': '1', 22:36:25 INFO - 'PAGER': '/bin/cat', 22:36:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:36:25 INFO - 'PWD': '/builds/slave/test', 22:36:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:36:25 INFO - 'SHELL': '/bin/bash', 22:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RyR1rv4Mkq/Listeners', 22:36:25 INFO - 'TMPDIR': '/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/', 22:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:36:25 INFO - 'USER': 'cltbld', 22:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:36:25 INFO - 'XPC_FLAGS': '0x0', 22:36:25 INFO - 'XPC_SERVICE_NAME': '0', 22:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:36:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0054', '--webServer', 'localhost'] with output_timeout 3600 22:36:26 INFO - mozversion INFO | application_buildid: 20151117210240 22:36:26 INFO - mozversion INFO | application_changeset: fb5b48c3abe6dc120cde93464372d2bf9095a7a2 22:36:26 INFO - mozversion INFO | application_display_name: Nightly 22:36:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:36:26 INFO - mozversion INFO | application_name: Firefox 22:36:26 INFO - mozversion INFO | application_remotingname: firefox 22:36:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:36:26 INFO - mozversion INFO | application_vendor: Mozilla 22:36:26 INFO - mozversion INFO | application_version: 45.0a1 22:36:26 INFO - mozversion INFO | platform_buildid: 20151117210240 22:36:26 INFO - mozversion INFO | platform_changeset: fb5b48c3abe6dc120cde93464372d2bf9095a7a2 22:36:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:36:26 INFO - mozversion INFO | platform_version: 45.0a1 22:36:26 INFO - 2015-11-17 22:36:26,332 DEBUG : using testdate: 1447828586 22:36:26 INFO - 2015-11-17 22:36:26,332 DEBUG : actual date: 1447828586 22:36:26 INFO - 2015-11-17 22:36:26,342 INFO : starting webserver on 'localhost:49263' 22:36:26 INFO - 2015-11-17 22:36:26,343 INFO : Starting test suite t-yosemite-r5-0054.e 22:36:26 INFO - 2015-11-17 22:36:26,343 INFO : Starting test dromaeo_css 22:36:26 INFO - 2015-11-17 22:36:26,343 DEBUG : operating with platform_type : mac_ 22:36:26 INFO - 2015-11-17 22:36:26,344 INFO : Initialising browser for dromaeo_css test... 22:36:26 INFO - 2015-11-17 22:36:26,378 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpNUOWM4/profile http://localhost:49263/getInfo.html 22:36:30 INFO - 2015-11-17 22:36:30,739 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:36:30 INFO - 2015-11-17 22:36:30,739 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:36:30 INFO - 2015-11-17 22:36:30,739 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:36:30 INFO - 2015-11-17 22:36:30,739 DEBUG : BROWSER_OUTPUT: __metrics 22:36:31 INFO - 2015-11-17 22:36:31,429 INFO : Browser initialized. 22:36:31 INFO - 2015-11-17 22:36:31,430 INFO : Running cycle 1/1 for dromaeo_css test... 22:36:31 INFO - 2015-11-17 22:36:31,430 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpNUOWM4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:36:43 INFO - 2015-11-17 22:36:43,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 241455104 22:36:43 INFO - 2015-11-17 22:36:43,623 DEBUG : BROWSER_OUTPUT: 22:37:33 INFO - 2015-11-17 22:37:33,460 DEBUG : BROWSER_OUTPUT: 1447828653456 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:39:44 INFO - 2015-11-17 22:39:44,671 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49263/tests/dromaeo/cssquery-ext.html) 22:39:45 INFO - 2015-11-17 22:39:45,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 265834496 22:39:45 INFO - 2015-11-17 22:39:45,708 DEBUG : BROWSER_OUTPUT: 22:42:47 INFO - 2015-11-17 22:42:47,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-ext.html (next: http://localhost:49263/tests/dromaeo/cssquery-jquery.html) 22:42:48 INFO - 2015-11-17 22:42:48,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 272707584 22:42:48 INFO - 2015-11-17 22:42:48,359 DEBUG : BROWSER_OUTPUT: 22:45:50 INFO - 2015-11-17 22:45:50,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49263/tests/dromaeo/cssquery-mootools.html) 22:45:50 INFO - 2015-11-17 22:45:50,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 275042304 22:45:50 INFO - 2015-11-17 22:45:50,709 DEBUG : BROWSER_OUTPUT: 22:48:52 INFO - 2015-11-17 22:48:52,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49263/tests/dromaeo/cssquery-prototype.html) 22:48:53 INFO - 2015-11-17 22:48:53,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 277606400 22:48:53 INFO - 2015-11-17 22:48:53,004 DEBUG : BROWSER_OUTPUT: 22:51:55 INFO - 2015-11-17 22:51:55,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49263/tests/dromaeo/cssquery-yui.html) 22:51:56 INFO - 2015-11-17 22:51:56,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 283172864 22:51:56 INFO - 2015-11-17 22:51:56,174 DEBUG : BROWSER_OUTPUT: 22:54:58 INFO - 2015-11-17 22:54:58,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-yui.html (next: http://localhost:49263/tests/dromaeo/cssquery-dojo.html) 22:54:58 INFO - 2015-11-17 22:54:58,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 287264768 22:54:58 INFO - 2015-11-17 22:54:58,825 DEBUG : BROWSER_OUTPUT: 22:54:58 INFO - 2015-11-17 22:54:58,825 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:54:58 INFO - 2015-11-17 22:54:58,825 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:54:58 INFO - 2015-11-17 22:54:58,825 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:54:58 INFO - 2015-11-17 22:54:58,826 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:54:58 INFO - 2015-11-17 22:54:58,827 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2708.6072519484674;2733.466973940081;2740.1916434651775;2812.535931571291;2819.1401622505127;4634.513376095512;4645.55867192617;4666.48668646449;4755.785989630466;4770.141374552583;4536.1381337545845;4554.20301447247;4608.423947006624;4621.329907163467;4765.166095933215;4224.049588842517;4276.657867370618;4302.419173411597;4355.063661312817;4371.082072764707;4255.893602659928;4277.529471758104;4280.6361459275995;4322.308430651096;4366.868993930188;4090.5909409059154;4165.208610364021;4257.254980378421;4282.357646353056;4306.892327691833;4276.422682937795;4302.376155457472;4327.935080973788;4345.826166953318;4376.496702879178;4281.464816897887;4291.334843099325;4349.238883195429;4352.934705979413;4399.318105693623;4423.8672839814535;4449.822007119711;4564.566366195206;4663.230566956482;4666.066786642685;4995.125852975751;5016.54851063406;5032.723200223986;5047.268146118792;5091.1090559152;4821.662483626147;5045.318881950926;5058.974705126451;5094.465081166498;5162.974185129088;4567.748773817472;4580.519045500175;4602.631789456836;4660.464046634646;4722.362481065013;5156.226566015128;5165.690058596496;5188.092083885305;5193.844184674465;5219.295395121686;4754.857354279377;4799.66402351832;4964.801407943714;4973.751312434364;4982.377202849644;4870.634702397264;4971.801127954914;4983.202687569971;5027.245913112989;5077.060743762416;4916.2625606158645;4965.702057876539;5015.573676237561;5046.949530504721;5083.161278389099;4774.427068751772;4830.541098595628;4873.342098816685;4964.230544265644;5105.208692652571;3836;3846.5961074087377;3890.6692931101175;3903.726739128291;3945;3517.402041652925;3533.4169861972487;3546.361654902142;3566.0906468850276;3589.4615807629066;4537.342085397599;4637.976810115928;4697.412823397075;4798.2322828348;4888.877778055577;5067.797288108434;5098.056859481007;5105.412877519058;5157.123289040872;5161.458046905096;4759.928601070987;4774.809007639656;4775.140474714584;4814.6870453420415;4862.586680132228;4251.4685664291965;4308.073764140662;4317.805698743564;4356.063446359048;4422.977885110618;5208.869778255574;5229.973850130725;5254.500822421864;5301.284326616012;5347.786088556492;4889.755512224446;5078.466760990191;5123.538881500683;5137.229415587692;5171.870703232299;5097.464766199496;5150.201718733602;5189.091908916;5199;5266.762995665281;4947.2579113133315;4963;4971.353724015855;5008.048470790538;5080.618953578422;4761.880952976203;4923.8276660316715;5041.218611115283;5069.9746501267255;5070.112730272114;4818.71087734737;4846.369971903771;4888.437829649636;4889.3888263967;4949.084419382426;4891.217405215149;4950.059488697136;4955.702657840541;4958.603311735124;4968.22992436173;4293.119910418294;4567.771611419349;4754.358161648133;4846.365723792014;4907.877303067309;4952.158133117451;4971.229459433794;4990.8253211137435;5006.199008158677;5022.196448568212;4879.048585525788;4884.291777692286;4947.554720075211;4958.404991401055;4989.850304490871 22:54:58 INFO - 2015-11-17 22:54:58,829 DEBUG : BROWSER_OUTPUT: |1;ext.html;483.56237604967515;485.3981063481283;503.5694481218557;513.1276829390038;513.2301547678483;34088.31823363531;35060.474092888566;35214.47178292325;35342.82328588353;35485.11287217821;36710.816445917735;37646.4353034704;37672.623273767254;37696.81151594245;37760.62239377605;7983.241592048761;8063.435559510807;8112.878306825402;8155.469894456842;8195;7916.525008499509;8032.759017229492;8055.154208808079;8065.556394398306;8070.435069545134;7932.325752311061;7947.324477419397;8030.638621262057;8031.955845740045;8048.195180481964;7944.165862584432;8038.959805200995;8123.431359804816;8124.878126828103;8130.593470326519;7664.923350766477;7822.882656760153;7888.526688398657;7940.483868548526;7959.920400795976;34689.132771680655;34760.82619586886;34833.129171770655;35057.29885402303;35287;2651.2443953473166;2675.2108128102063;2680.4505076459277;2743.0810678422754;3017.6982301769867;23533.529329413486;23933.64099538508;24118.2764517063;24751.752482475305;25394.36514087144;2053.7946205379494;2068.2317612783363;2091.362134548962;2120.3003009007143;2178.836587255946;221403;225816;225916.8704156485;226294;226618;44534;45572.54427455683;50666.74666626717;51269.743651281504;53120.734396327774;47338.763306183246;47723.28415073777;47850.5214947846;47949.760251199215;48162;14063.156210627396;14098.718025639635;14112.788308175386;14302;14303.713925721635;10523.684289471328;10733.409662468639;10769.407682577534;10781.730456738644;10793.136549076055;16965.321387144624;17132.828671713374;17133.22900469482;17318;17353.65292694139;6875.48433867462;7085.610291434021;7112.6443677815905;7135.357817796424;7154.964225178945;806.3106044332012;813.60540138033;859.9656013759379;926.967556135532;938.77000134966;24581.87709061443;24903.129139647754;25144.874275628506;25170.496590068095;25604.74395256061;909.2816674826945;978.2467500024941;989.4162444157981;1041.6406339812752;1082.437132691012;12998.220106793622;13106.279154646585;13135.211887286794;13204.537841175705;13378.665533361744;248895;251222;253624;255194;258737;46650.76674616605;46883;46983.29525057127;47102;47152.52847471481;1188.2751521571834;1205.2406983600276;1206.704357432417;1215.9088068394728;1218.2629509147016;24241.15155969603;24924.252272431855;25147.622785657863;25153;25172.74827251704;40863;41206.38190427206;41446;41505.1698966025;41515;236477;239193;239275;239877;240443;27094.458110838066;27397.45205095847;27854.721452785212;27918.581221281293;28120;32733.672663274014;33062.33875322432;33213;33416;33703;28496.145115646563;28769.56845647359;28936.56595151032;28978.13065608035;28978.710212898444;28298.43403131967;29068.12795616135;30459.390812184076;30801.383972320877;31019.84490077535;30823.53764693576;30902.53646195354;31109.377812444076;31160.220994474414;31350.843245784537;25771.355716107246;26509.204723857543;28763.85618071896;28795.42409151847;29007.41985160327;20609.94928713044;20832.895835521333;20979.160833567097;21032.579348413252;21057.47356316043 22:54:58 INFO - 2015-11-17 22:54:58,830 DEBUG : BROWSER_OUTPUT: |2;jquery.html;291.43607120222356;291.6631290859057;291.82927987127516;294.6817437167859;301.09670987038885;12536.435860386282;12777.872221277785;14627.488037918662;14997.933688838422;15158;15242.314095865684;15257.847421525781;16319.755203671924;16346.754798678;16434.260458279376;4088.632023117919;4168.0413504893895;4185.874423767276;4186.37204419338;4639.234526303156;4005.2390045891334;4128.422020917074;4137.027798467373;4161.563035881234;4182.372644103379;4072.5316588592395;4076.4496792932873;4094.61101195386;4094.651954583864;4095.201435720036;4041.7574945503216;4207.810648520794;4222.19778242133;4224.429701990253;4243.08773613673;3555.2178520725397;3570.80360580168;3572.1069732566857;3579.3378225028455;3587.1570181007705;11214.831777523344;11337.603183888525;11523.827142592867;11562.653120406401;11571.94214028933;1547.3114464063497;1589.9364025438967;1593.6573636668172;1604.5908293385228;1655.0897006646417;8270.503769773773;8337.708180213724;8452.408331416804;8550.273226775731;8671.21959023691;1316.795896636023;1322.8409204103975;1351.229799014562;1407.0030834322827;1409.0981771666143;49855.750721246164;51428.74285628548;51609;51994.48005519972;52373;5550.250716153349;5580.497755202051;5588.832335029955;5684.033714268584;5686.118651608925;6449.419552240321;6457.903131453032;6463.192100987377;6471.611703297817;6486.772962946275;4714.127886340969;4752.928706069411;4802.927956080662;4815.903681926342;4834.7824347904425;5024.62315326352;5137.743112844343;5156.278121063054;5198.090334191501;5213.452587478336;2509.4102885821817;2511.4098186926058;2522.621606758964;2525.0783464035494;2531.7847982921658;878.6836738774036;894.4856707393275;930.5114814722325;947.2469386837481;965.3290962780941;366.8734286671094;373.44729799895765;374.8200863585494;380.1882979838066;405.97491334380925;9786.51067446639;10253.282270241012;10282.948585257176;10407.47962601882;10419.42693151884;385.96333348331865;393.15079428434444;401.83524754850373;402.2196937940386;408.3242234102565;5275.3142091528625;5392.272043274186;5666.603337766399;5673.971630141823;5730.455606717355;457554;462695;467569;470190;475776;62849.371506284355;63675.36324636694;64835;64981.675091625184;65622.34377656257;426.63096421595094;433.5361163555029;434.12307139577877;437.81611723076384;442.5530214483395;9242.399244049115;9531.285153613368;9561.139497445263;9569.569369378256;9615.086566776145;28802.27994300159;29504.262393440335;30188.09435716932;30306.242343941576;31090.37819243557;38575.22849543049;38991.805040974614;39136.608633913296;39171.41242881416;39926.80036599799;5241.135212689864;5411.567074633941;5428.077226871363;5440.102383106743;5445.373782015119;9875.506224688594;10085.69742907714;10332.586696532055;10349;10377.688669339932;8420.11588783169;8679.869801953102;8828.117188281121;8863.290936725176;8923.553822308988;8525.44584601999;8543.145685431407;8585.699500517452;8594.527300998505;8856.512891791013;8836.381453298465;8841.204291613785;8858.202761751474;9054.049324820799;9143.26853851677;5345.251664766858;5403.675779453245;5407.945920540744;5416.8104116355735;5448.073827449422;8833.602487887933;8856.291496680378;8987;9002.099790020946;9021.052789457013 22:54:58 INFO - 2015-11-17 22:54:58,834 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1193.5404869125389;1194.4624918786546;1236.6351926181776;1550.232634845751;1564.2178910544728;5677.886442271152;5720.856978575538;6350.396712312328;6702.832429189267;6710;6334.524910631698;6360.300366959642;6456.418922296993;6465.547411681184;6466.579672321296;1920.6350793349254;1930.94207173785;1959.9902000489978;1962.2641509433963;1963.0184907546227;1983.4545499987476;1986.8211860932513;1998.6202621501868;2015.0730663894626;2022.413500084981;1946.776120746111;1976.4663540843962;1976.9406917792417;2005.147812179825;2005.2981456490186;1947.552063025512;1950.2101648832245;1951.6877299632063;1960.2942940541536;1977.8714383565166;1949.220311875247;1962.4112766170235;1992.7608686957512;1992.950176245591;2011.597680463913;6343;6454.22549294083;6474.7086381112495;6476.8704625907685;6504.60972341661;4015.2371049500503;4097.569755175693;4153.584641535853;4159.396887451333;4177;2239.921602743896;2302.470431800695;2507.761762632547;2569.486102779452;2606.2832721001687;782.7360997293215;792.8691765858626;815.9061707903548;819.9262066413992;833.2209384225769;8304.875426868603;8334.958325208396;8363.874541881876;8367.790805229857;8427.536485493296;3758.4550240215017;3775.2638235543805;3874.593167717349;3890.105275786585;3895.4935858338235;7314.195438501761;7334.66993985272;7361.595112268769;7370.8894366584545;7383.2616738326815;4183.853565125206;4197.496300443966;4201.957980420218;4219.282721937278;4221.451211342506;3770.9434358484646;3790.3177428063213;3799.848006079781;3818.8281527331337;3835.347990841564;3120.8595613197463;3132.5144602586633;3142.261568531393;3183.602049743782;3187.282861356223;1063.6436793674052;1074.7044562745152;1079.438691880218;1085.2240647936605;1089.2320913755784;900.5092224737534;902.5306840443064;903.1555495611493;917.8990311065777;1112.5494174859195;6021.548383871227;6038.426349496791;6044.727987240584;6083.847903802441;6092.543059270483;403.50772058089086;415.56988516885485;417.83077853469393;421.8207261913736;423.93217085266207;4788.592969597623;4799.352087468217;4805.399325084364;4836.322914791932;4849.515048495122;6934.098567186335;7198.604076775723;7368.115826100902;7395.963020184865;7584.165741768401;7424.294692004359;7438.256174382518;7492.213317601682;7500.662470188855;7528.736494222676;5968.880622387528;5996.67018313997;6013.308469525973;6080.361562036011;6139.6009259398;5765.827025189251;5768.682722450306;5840.123981402823;5843.94156058434;5845.357010728731;6594.175728033996;6664.300248474035;6729.596224226562;6737.023131645786;6841.3842754152365;6868.62222577763;6940.063091482585;6992.4406047517095;7003.719851206099;7043.049188359506;5490.588205884655;5526.392096869422;5601.775928962796;5614.915776263441;5616.129499927518;6008.66882891466;6056.818295451144;6087.0565062413625;6142.600730952474;6143.109249158936;5704.857378565569;5770.596058275881;5807.477327040587;5827.388124246893;5904.439078287556;5629.099344104923;5695.088785794419;5740.971295143498;5795.82612521625;5811.244538210006;5770.336411312753;5812.099124635688;5817.040188368872;5834.766609335748;5854.121881717776;5216.765245563883;5236.319278493771;5351.1973204019705;5351.384590771955;5363.168708850135;5251.474852514718;5392.191171324333;5408.513233808976;5455.5908306876345;5472.91790623133 22:54:58 INFO - 2015-11-17 22:54:58,835 DEBUG : BROWSER_OUTPUT: |4;prototype.html;269.3186238815796;274.4716420889787;280.8174686453805;282.25906994140394;283.1491368437844;5263.578913686905;5362.490563396481;5491.725413729312;5526.143447765598;5565.638233514819;5446.373667028293;5472.042392581292;5499.890002199953;5526.972365138168;5574.358948720898;4192.643625291838;4214.852480163195;4232.195882782277;4251.277282861905;4253.2131555662145;4168.333066709327;4236.983124050236;4246.299360605496;4247.384129301249;4260.211860805745;4146.502419709639;4171.937420938689;4195.202911446815;4209;4210.473690788652;4034.3141665916864;4133.111381053073;4182.728122672017;4188.099558594886;4196.916061678779;3534.6995505382074;3592.4431713084514;3593.1196856770257;3604.9279014419567;3605.603383627799;5410.756515956791;5416.21464887593;5422.864428389283;5439.918401223985;5469.234307196995;4686.343911852309;4715.622750180011;4763.071201115784;4771.28430735389;4781.330613714083;5590.18942253371;5701.486866182064;5735.942640573582;5871.500922421599;5879.265091863517;3774.9433758493647;3791.6777073948747;3799.810009499514;3819.4079917612817;3849.30712471755;5907.645541267538;6018.909716354258;6104.2980057293535;6112.235970503687;6131.724072416752;3865.420186971977;3867.207222519377;3892.766434013968;3916.6083391660604;3922.941155882664;3942.8817135485983;3996.100877302642;3998.7600743955454;4000.4799376081505;4009.1179940413062;4640.141573808856;4660.347551342815;4673.696209746356;4682.321063445849;4697;5613;5787;5802.274715660543;5812.59311848175;5827.650340979555;1378.7862881253423;1381.081580748811;1384.6469150366793;1403.3264033263886;1412.7033323002079;897.9012308646044;901.1799262670938;902.4224496322358;908.4367692030983;912.7535565397438;5528.198411230349;5558.166275058774;5588.3573389060775;5611.410801865827;5628.97185514078;6022.156898034279;6049.18336024631;6066.787662431793;6079.8480037998515;6093.96953015241;5547.583931205176;5560;5575.275214222206;5578.414266501959;5612.663240205601;3191.505316675919;3242.0760083376126;3268.313654132611;3299.1257316811066;3301.4882693182117;6201.286852011986;6218.844528886814;6220.160278362454;6225.28409232944;6232.594881332699;6164.506839452833;6166.506679465632;6199.380061993765;6217.720202590804;6222.222222222223;6030.969845150747;6135.877282454415;6215.595986260879;6230.657313847782;6240.65676387794;6061.333253342217;6065.6663883486835;6074.665893375906;6078.908816367846;6085.300190478151;5880.441358070976;5888.263967004124;5896.616719913192;5898.970505147447;5914.408559144224;6217.844553886189;6224.906626400517;6246.875062498815;6254.3745625437095;6262.185915830913;3920.2159568085926;3944.211157768515;3954.5452272988973;3965.4250133731025;3969.8015099244344;6100.328963814066;6101.694915254131;6102.786402475892;6115.6330620162935;6132.938670613236;5892.734826932884;5931.110333450017;5956.583039187215;5958.165856779968;5972.193753843176;5763.9135412968;5821.854453638693;5834.912476312774;5931.525477961839;5941.346451890202;5723.170140329712;5757.971210143923;5758.193852860519;5764.048931926185;5764.827055188351;5853.531717462508;5921.467067963904;5928.229330187048;5936.079907614327;5956.880862382642;5593.300837395325;5780.7398667060925;5804.01331773591;5815.185873977562;5858.765649373977 22:54:58 INFO - 2015-11-17 22:54:58,839 DEBUG : BROWSER_OUTPUT: |5;yui.html;572.1169815623653;605.6063558686853;607.696151924038;651.1535004494158;662.7282814046242;11830.349330786803;12021.819672704916;12233.143679942408;12238.938805305972;12256.26462412256;10593.470326483664;11383.886161138385;11511.194216404854;12316;12327.260364378144;748.4760667532735;757.685560492395;757.8825282081286;758.2985738192177;760.1334478694293;747.2154238050053;750.3097150621414;761.958092304923;762.2453770766929;766.2529034191674;792.1286584756779;792.1998781230941;800.8718605023197;802.3701394405393;803.4576660753997;784.8548018616546;791.9881201781977;794.5629903553023;795.6340083561511;798.5448294472153;585.125237769533;590.2238556298497;590.6249531547455;592.5259792166249;593.3325009364465;11706.53173873044;11900.107491938139;11904.285742855456;11925.761484770343;12024.218425802295;9772.26707996896;9955.651552195712;10140.08739213467;10179.389236645826;10466.267361284714;7878.123651728015;8131.59342032896;8200.220979007045;8246.422750407473;8253.669853205865;2832.5609530522597;2868.584055311989;2887.4946884295373;2933.346528774317;2959.482090634152;38276.61723382759;38543.807280963694;39743.8012809937;41632.167356653;42634.360484592755;7848.13670496245;7865.331446827084;7889.447738658354;7890.684372625031;7902.24928631779;16612.750808737877;16639.50081497557;16640.6671866562;16647.83352166487;16690.49928502147;5766.798162064308;5770.798022069292;6055.061465472859;6078.483328917092;6120.418560236771;3363.680450357212;3402.897913062612;3407.6762707542744;3489.0753950203216;3553.7867727936405;2570.3445621366805;2593.5072336256053;2594.338443696883;2597.142942828862;2599.4671092426006;378.60624950052187;380.3894748927931;382.8526017483289;387.97090218233745;390.1358490942576;405.54578871663927;440.3153096934298;448.91021795640347;491.68286455236887;553.1674829381835;6361.083259755865;7143.285671432919;7162.212156662763;7479.401647868158;7647.847043059108;432.93505974103505;495.20519566095896;495.3671237373349;504.4325134223998;525.511274514705;3264.7061764441314;3282.950755738666;3365.1082463147286;3401.8809341672923;3461.463473161664;51861.48138518642;51931.740341298806;51942.22086668703;52268.21597676038;52619.73690131525;44086.77956610196;44954.77522612366;45021.32468012982;45044.549554504694;45541.772291138994;38624.613753862664;41641.167176656905;41734;42758.78620606877;42940.78529607395;6752.189737231563;7033.9296607033275;7150;7372.189059203591;7410;30904.381912362078;31436.371272573964;31502.842485787423;31993;32045.51931721073;36524.086897827765;37860.432093518066;38990;41001.79499102486;41215.175696486505;6186.19579454668;6266.655333956493;6316;6361.936380636134;6428.132202152649;9176.862347064665;9232.122948319899;9239.953800230956;9307;9423.905760942303;8793.340499462438;8809.779755505908;8923.821523569623;8927.955360223157;9100.36297459198;9266.351355405057;9282.35023548345;9311.906880931105;9312.34813563044;9392.248620110238;8637.253246172835;8703.825923481621;8944.955275223581;8975.640974360953;9013.729588112366;7652.617369131633;7659.348955338635;7920.801979950547;8335.999680038434;8402;7421.777346679608;7630.351420129351;7751.651175696994;8017.639206235617;8106.513609183467 22:54:58 INFO - 2015-11-17 22:54:58,839 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:54:58 INFO - 2015-11-17 22:54:58,839 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:54:58 INFO - 2015-11-17 22:54:58,839 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,290 22:54:58 INFO - 2015-11-17 22:54:58,840 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:54:58 INFO - 2015-11-17 22:54:58,840 DEBUG : BROWSER_OUTPUT: __startTimestamp1447829698823__endTimestamp 22:54:58 INFO - 2015-11-17 22:54:58,840 DEBUG : BROWSER_OUTPUT: 22:54:58 INFO - 2015-11-17 22:54:58,840 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:54:58 INFO - 2015-11-17 22:54:58,840 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:54:58 INFO - 2015-11-17 22:54:58,840 DEBUG : BROWSER_OUTPUT: 22:54:58 INFO - 2015-11-17 22:54:58,840 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4669.81 Median:4830.54 stddev:520.44 (10.8%) stddev-sans-first:498.78 22:54:58 INFO - 2015-11-17 22:54:58,841 DEBUG : BROWSER_OUTPUT: Values: 2708.6 2733.5 2740.2 2812.5 2819.1 4634.5 4645.6 4666.5 4755.8 4770.1 4536.1 4554.2 4608.4 4621.3 4765.2 4224.0 4276.7 4302.4 4355.1 4371.1 4255.9 4277.5 4280.6 4322.3 4366.9 4090.6 4165.2 4257.3 4282.4 4306.9 4276.4 4302.4 4327.9 4345.8 4376.5 4281.5 4291.3 4349.2 4352.9 4399.3 4423.9 4449.8 4564.6 4663.2 4666.1 4995.1 5016.5 5032.7 5047.3 5091.1 4821.7 5045.3 5059.0 5094.5 5163.0 4567.7 4580.5 4602.6 4660.5 4722.4 5156.2 5165.7 5188.1 5193.8 5219.3 4754.9 4799.7 4964.8 4973.8 4982.4 4870.6 4971.8 4983.2 5027.2 5077.1 4916.3 4965.7 5015.6 5046.9 5083.2 4774.4 4830.5 4873.3 4964.2 5105.2 3836.0 3846.6 3890.7 3903.7 3945.0 3517.4 3533.4 3546.4 3566.1 3589.5 4537.3 4638.0 4697.4 4798.2 4888.9 5067.8 5098.1 5105.4 5157.1 5161.5 4759.9 4774.8 4775.1 4814.7 4862.6 4251.5 4308.1 4317.8 4356.1 4423.0 5208.9 5230.0 5254.5 5301.3 5347.8 4889.8 5078.5 5123.5 5137.2 5171.9 5097.5 5150.2 5189.1 5199.0 5266.8 4947.3 4963.0 4971.4 5008.0 5080.6 4761.9 4923.8 5041.2 5070.0 5070.1 4818.7 4846.4 4888.4 4889.4 4949.1 4891.2 4950.1 4955.7 4958.6 4968.2 4293.1 4567.8 4754.4 4846.4 4907.9 4952.2 4971.2 4990.8 5006.2 5022.2 4879.0 4884.3 4947.6 4958.4 4989.9 22:54:58 INFO - 2015-11-17 22:54:58,841 DEBUG : BROWSER_OUTPUT: 22:54:58 INFO - 2015-11-17 22:54:58,841 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38747.77 Median:30812.46 stddev:62393.30 (202.5%) stddev-sans-first:62502.18 22:54:58 INFO - 2015-11-17 22:54:58,841 DEBUG : BROWSER_OUTPUT: Values: 483.6 485.4 503.6 513.1 513.2 34088.3 35060.5 35214.5 35342.8 35485.1 36710.8 37646.4 37672.6 37696.8 37760.6 7983.2 8063.4 8112.9 8155.5 8195.0 7916.5 8032.8 8055.2 8065.6 8070.4 7932.3 7947.3 8030.6 8032.0 8048.2 7944.2 8039.0 8123.4 8124.9 8130.6 7664.9 7822.9 7888.5 7940.5 7959.9 34689.1 34760.8 34833.1 35057.3 35287.0 2651.2 2675.2 2680.5 2743.1 3017.7 23533.5 23933.6 24118.3 24751.8 25394.4 2053.8 2068.2 2091.4 2120.3 2178.8 221403.0 225816.0 225916.9 226294.0 226618.0 44534.0 45572.5 50666.7 51269.7 53120.7 47338.8 47723.3 47850.5 47949.8 48162.0 14063.2 14098.7 14112.8 14302.0 14303.7 10523.7 10733.4 10769.4 10781.7 10793.1 16965.3 17132.8 17133.2 17318.0 17353.7 6875.5 7085.6 7112.6 7135.4 7155.0 806.3 813.6 860.0 927.0 938.8 24581.9 24903.1 25144.9 25170.5 25604.7 909.3 978.2 989.4 1041.6 1082.4 12998.2 13106.3 13135.2 13204.5 13378.7 248895.0 251222.0 253624.0 255194.0 258737.0 46650.8 46883.0 46983.3 47102.0 47152.5 1188.3 1205.2 1206.7 1215.9 1218.3 24241.2 24924.3 25147.6 25153.0 25172.7 40863.0 41206.4 41446.0 41505.2 41515.0 236477.0 239193.0 239275.0 239877.0 240443.0 27094.5 27397.5 27854.7 27918.6 28120.0 32733.7 33062.3 33213.0 33416.0 33703.0 28496.1 28769.6 28936.6 28978.1 28978.7 28298.4 29068.1 30459.4 30801.4 31019.8 30823.5 30902.5 31109.4 31160.2 31350.8 25771.4 26509.2 28763.9 28795.4 29007.4 20609.9 20832.9 20979.2 21032.6 21057.5 22:54:58 INFO - 2015-11-17 22:54:58,841 DEBUG : BROWSER_OUTPUT: 22:54:58 INFO - 2015-11-17 22:54:58,841 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23146.14 Median:440.18 stddev:76482.17 (17375.0%) stddev-sans-first:76677.47 22:54:58 INFO - 2015-11-17 22:54:58,843 DEBUG : BROWSER_OUTPUT: Values: 291.4 291.7 291.8 294.7 301.1 12536.4 12777.9 14627.5 14997.9 15158.0 15242.3 15257.8 16319.8 16346.8 16434.3 4088.6 4168.0 4185.9 4186.4 4639.2 4005.2 4128.4 4137.0 4161.6 4182.4 4072.5 4076.4 4094.6 4094.7 4095.2 4041.8 4207.8 4222.2 4224.4 4243.1 3555.2 3570.8 3572.1 3579.3 3587.2 11214.8 11337.6 11523.8 11562.7 11571.9 1547.3 1589.9 1593.7 1604.6 1655.1 8270.5 8337.7 8452.4 8550.3 8671.2 1316.8 1322.8 1351.2 1407.0 1409.1 49855.8 51428.7 51609.0 51994.5 52373.0 5550.3 5580.5 5588.8 5684.0 5686.1 6449.4 6457.9 6463.2 6471.6 6486.8 4714.1 4752.9 4802.9 4815.9 4834.8 5024.6 5137.7 5156.3 5198.1 5213.5 2509.4 2511.4 2522.6 2525.1 2531.8 878.7 894.5 930.5 947.2 965.3 366.9 373.4 374.8 380.2 406.0 9786.5 10253.3 10282.9 10407.5 10419.4 386.0 393.2 401.8 402.2 408.3 5275.3 5392.3 5666.6 5674.0 5730.5 457554.0 462695.0 467569.0 470190.0 475776.0 62849.4 63675.4 64835.0 64981.7 65622.3 426.6 433.5 434.1 437.8 442.6 9242.4 9531.3 9561.1 9569.6 9615.1 28802.3 29504.3 30188.1 30306.2 31090.4 38575.2 38991.8 39136.6 39171.4 39926.8 5241.1 5411.6 5428.1 5440.1 5445.4 9875.5 10085.7 10332.6 10349.0 10377.7 8420.1 8679.9 8828.1 8863.3 8923.6 8525.4 8543.1 8585.7 8594.5 8856.5 8836.4 8841.2 8858.2 9054.0 9143.3 5345.3 5403.7 5407.9 5416.8 5448.1 8833.6 8856.3 8987.0 9002.1 9021.1 22:54:58 INFO - 2015-11-17 22:54:58,843 DEBUG : BROWSER_OUTPUT: 22:54:58 INFO - 2015-11-17 22:54:58,845 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4492.79 Median:5622.61 stddev:2254.20 (40.1%) stddev-sans-first:2246.88 22:54:58 INFO - 2015-11-17 22:54:58,845 DEBUG : BROWSER_OUTPUT: Values: 1193.5 1194.5 1236.6 1550.2 1564.2 5677.9 5720.9 6350.4 6702.8 6710.0 6334.5 6360.3 6456.4 6465.5 6466.6 1920.6 1930.9 1960.0 1962.3 1963.0 1983.5 1986.8 1998.6 2015.1 2022.4 1946.8 1976.5 1976.9 2005.1 2005.3 1947.6 1950.2 1951.7 1960.3 1977.9 1949.2 1962.4 1992.8 1993.0 2011.6 6343.0 6454.2 6474.7 6476.9 6504.6 4015.2 4097.6 4153.6 4159.4 4177.0 2239.9 2302.5 2507.8 2569.5 2606.3 782.7 792.9 815.9 819.9 833.2 8304.9 8335.0 8363.9 8367.8 8427.5 3758.5 3775.3 3874.6 3890.1 3895.5 7314.2 7334.7 7361.6 7370.9 7383.3 4183.9 4197.5 4202.0 4219.3 4221.5 3770.9 3790.3 3799.8 3818.8 3835.3 3120.9 3132.5 3142.3 3183.6 3187.3 1063.6 1074.7 1079.4 1085.2 1089.2 900.5 902.5 903.2 917.9 1112.5 6021.5 6038.4 6044.7 6083.8 6092.5 403.5 415.6 417.8 421.8 423.9 4788.6 4799.4 4805.4 4836.3 4849.5 6934.1 7198.6 7368.1 7396.0 7584.2 7424.3 7438.3 7492.2 7500.7 7528.7 5968.9 5996.7 6013.3 6080.4 6139.6 5765.8 5768.7 5840.1 5843.9 5845.4 6594.2 6664.3 6729.6 6737.0 6841.4 6868.6 6940.1 6992.4 7003.7 7043.0 5490.6 5526.4 5601.8 5614.9 5616.1 6008.7 6056.8 6087.1 6142.6 6143.1 5704.9 5770.6 5807.5 5827.4 5904.4 5629.1 5695.1 5741.0 5795.8 5811.2 5770.3 5812.1 5817.0 5834.8 5854.1 5216.8 5236.3 5351.2 5351.4 5363.2 5251.5 5392.2 5408.5 5455.6 5472.9 22:54:58 INFO - 2015-11-17 22:54:58,845 DEBUG : BROWSER_OUTPUT: 22:54:58 INFO - 2015-11-17 22:54:58,845 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4849.91 Median:5583.39 stddev:1506.50 (27.0%) stddev-sans-first:1470.98 22:54:58 INFO - 2015-11-17 22:54:58,847 DEBUG : BROWSER_OUTPUT: Values: 269.3 274.5 280.8 282.3 283.1 5263.6 5362.5 5491.7 5526.1 5565.6 5446.4 5472.0 5499.9 5527.0 5574.4 4192.6 4214.9 4232.2 4251.3 4253.2 4168.3 4237.0 4246.3 4247.4 4260.2 4146.5 4171.9 4195.2 4209.0 4210.5 4034.3 4133.1 4182.7 4188.1 4196.9 3534.7 3592.4 3593.1 3604.9 3605.6 5410.8 5416.2 5422.9 5439.9 5469.2 4686.3 4715.6 4763.1 4771.3 4781.3 5590.2 5701.5 5735.9 5871.5 5879.3 3774.9 3791.7 3799.8 3819.4 3849.3 5907.6 6018.9 6104.3 6112.2 6131.7 3865.4 3867.2 3892.8 3916.6 3922.9 3942.9 3996.1 3998.8 4000.5 4009.1 4640.1 4660.3 4673.7 4682.3 4697.0 5613.0 5787.0 5802.3 5812.6 5827.7 1378.8 1381.1 1384.6 1403.3 1412.7 897.9 901.2 902.4 908.4 912.8 5528.2 5558.2 5588.4 5611.4 5629.0 6022.2 6049.2 6066.8 6079.8 6094.0 5547.6 5560.0 5575.3 5578.4 5612.7 3191.5 3242.1 3268.3 3299.1 3301.5 6201.3 6218.8 6220.2 6225.3 6232.6 6164.5 6166.5 6199.4 6217.7 6222.2 6031.0 6135.9 6215.6 6230.7 6240.7 6061.3 6065.7 6074.7 6078.9 6085.3 5880.4 5888.3 5896.6 5899.0 5914.4 6217.8 6224.9 6246.9 6254.4 6262.2 3920.2 3944.2 3954.5 3965.4 3969.8 6100.3 6101.7 6102.8 6115.6 6132.9 5892.7 5931.1 5956.6 5958.2 5972.2 5763.9 5821.9 5834.9 5931.5 5941.3 5723.2 5758.0 5758.2 5764.0 5764.8 5853.5 5921.5 5928.2 5936.1 5956.9 5593.3 5780.7 5804.0 5815.2 5858.8 22:54:58 INFO - 2015-11-17 22:54:58,847 DEBUG : BROWSER_OUTPUT: 22:54:58 INFO - 2015-11-17 22:54:58,847 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11791.99 Median:3177.96 stddev:14193.17 (446.6%) stddev-sans-first:14207.98 22:54:58 INFO - 2015-11-17 22:54:58,848 DEBUG : BROWSER_OUTPUT: Values: 572.1 605.6 607.7 651.2 662.7 11830.3 12021.8 12233.1 12238.9 12256.3 10593.5 11383.9 11511.2 12316.0 12327.3 748.5 757.7 757.9 758.3 760.1 747.2 750.3 762.0 762.2 766.3 792.1 792.2 800.9 802.4 803.5 784.9 792.0 794.6 795.6 798.5 585.1 590.2 590.6 592.5 593.3 11706.5 11900.1 11904.3 11925.8 12024.2 9772.3 9955.7 10140.1 10179.4 10466.3 7878.1 8131.6 8200.2 8246.4 8253.7 2832.6 2868.6 2887.5 2933.3 2959.5 38276.6 38543.8 39743.8 41632.2 42634.4 7848.1 7865.3 7889.4 7890.7 7902.2 16612.8 16639.5 16640.7 16647.8 16690.5 5766.8 5770.8 6055.1 6078.5 6120.4 3363.7 3402.9 3407.7 3489.1 3553.8 2570.3 2593.5 2594.3 2597.1 2599.5 378.6 380.4 382.9 388.0 390.1 405.5 440.3 448.9 491.7 553.2 6361.1 7143.3 7162.2 7479.4 7647.8 432.9 495.2 495.4 504.4 525.5 3264.7 3283.0 3365.1 3401.9 3461.5 51861.5 51931.7 51942.2 52268.2 52619.7 44086.8 44954.8 45021.3 45044.5 45541.8 38624.6 41641.2 41734.0 42758.8 42940.8 6752.2 7033.9 7150.0 7372.2 7410.0 30904.4 31436.4 31502.8 31993.0 32045.5 36524.1 37860.4 38990.0 41001.8 41215.2 6186.2 6266.7 6316.0 6361.9 6428.1 9176.9 9232.1 9240.0 9307.0 9423.9 8793.3 8809.8 8923.8 8928.0 9100.4 9266.4 9282.4 9311.9 9312.3 9392.2 8637.3 8703.8 8945.0 8975.6 9013.7 7652.6 7659.3 7920.8 8336.0 8402.0 7421.8 7630.4 7751.7 8017.6 8106.5 22:54:58 INFO - 2015-11-17 22:54:58,848 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:54:58 INFO - 2015-11-17 22:54:58,848 DEBUG : BROWSER_OUTPUT: 22:54:59 INFO - 2015-11-17 22:54:59,345 INFO : Browser exited with error code: 0 22:54:59 INFO - 2015-11-17 22:54:59,377 INFO : Completed test dromaeo_css (00:18:33) 22:54:59 INFO - 2015-11-17 22:54:59,377 INFO : Starting test kraken 22:54:59 INFO - 2015-11-17 22:54:59,377 DEBUG : operating with platform_type : mac_ 22:54:59 INFO - 2015-11-17 22:54:59,377 INFO : Initialising browser for kraken test... 22:54:59 INFO - 2015-11-17 22:54:59,393 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpV5sqSM/profile http://localhost:49263/getInfo.html 22:55:02 INFO - 2015-11-17 22:55:02,589 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:55:02 INFO - 2015-11-17 22:55:02,589 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:55:02 INFO - 2015-11-17 22:55:02,590 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:55:02 INFO - 2015-11-17 22:55:02,590 DEBUG : BROWSER_OUTPUT: __metrics 22:55:03 INFO - 2015-11-17 22:55:03,303 INFO : Browser initialized. 22:55:03 INFO - 2015-11-17 22:55:03,303 INFO : Running cycle 1/1 for kraken test... 22:55:03 INFO - 2015-11-17 22:55:03,303 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpV5sqSM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:55:15 INFO - 2015-11-17 22:55:15,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 241299456 22:55:15 INFO - 2015-11-17 22:55:15,488 DEBUG : BROWSER_OUTPUT: 22:55:18 INFO - 2015-11-17 22:55:18,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection) 22:55:18 INFO - 2015-11-17 22:55:18,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 259788800 22:55:18 INFO - 2015-11-17 22:55:18,943 DEBUG : BROWSER_OUTPUT: 22:55:22 INFO - 2015-11-17 22:55:22,000 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-dft) 22:55:22 INFO - 2015-11-17 22:55:22,603 DEBUG : BROWSER_OUTPUT: RSS: Main: 266850304 22:55:22 INFO - 2015-11-17 22:55:22,604 DEBUG : BROWSER_OUTPUT: 22:55:25 INFO - 2015-11-17 22:55:25,867 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-fft) 22:55:26 INFO - 2015-11-17 22:55:26,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 267816960 22:55:26 INFO - 2015-11-17 22:55:26,452 DEBUG : BROWSER_OUTPUT: 22:55:28 INFO - 2015-11-17 22:55:28,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator) 22:55:29 INFO - 2015-11-17 22:55:29,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 267382784 22:55:29 INFO - 2015-11-17 22:55:29,216 DEBUG : BROWSER_OUTPUT: 22:55:31 INFO - 2015-11-17 22:55:31,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:55:32 INFO - 2015-11-17 22:55:32,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 268349440 22:55:32 INFO - 2015-11-17 22:55:32,157 DEBUG : BROWSER_OUTPUT: 22:55:35 INFO - 2015-11-17 22:55:35,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom) 22:55:36 INFO - 2015-11-17 22:55:36,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 265568256 22:55:36 INFO - 2015-11-17 22:55:36,230 DEBUG : BROWSER_OUTPUT: 22:55:39 INFO - 2015-11-17 22:55:39,799 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate) 22:55:40 INFO - 2015-11-17 22:55:40,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 266194944 22:55:40 INFO - 2015-11-17 22:55:40,389 DEBUG : BROWSER_OUTPUT: 22:55:43 INFO - 2015-11-17 22:55:43,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial) 22:55:44 INFO - 2015-11-17 22:55:44,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 267325440 22:55:44 INFO - 2015-11-17 22:55:44,229 DEBUG : BROWSER_OUTPUT: 22:55:45 INFO - 2015-11-17 22:55:45,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:55:46 INFO - 2015-11-17 22:55:46,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 267902976 22:55:46 INFO - 2015-11-17 22:55:46,573 DEBUG : BROWSER_OUTPUT: 22:55:48 INFO - 2015-11-17 22:55:48,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:55:49 INFO - 2015-11-17 22:55:49,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 267370496 22:55:49 INFO - 2015-11-17 22:55:49,223 DEBUG : BROWSER_OUTPUT: 22:55:51 INFO - 2015-11-17 22:55:51,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:55:52 INFO - 2015-11-17 22:55:52,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 267898880 22:55:52 INFO - 2015-11-17 22:55:52,148 DEBUG : BROWSER_OUTPUT: 22:55:55 INFO - 2015-11-17 22:55:55,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:55:55 INFO - 2015-11-17 22:55:55,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 267841536 22:55:55 INFO - 2015-11-17 22:55:55,666 DEBUG : BROWSER_OUTPUT: 22:55:58 INFO - 2015-11-17 22:55:58,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:55:59 INFO - 2015-11-17 22:55:59,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 267919360 22:55:59 INFO - 2015-11-17 22:55:59,242 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,148 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49263/tests/kraken/driver.html?testName=ai-astar) 22:56:01 INFO - 2015-11-17 22:56:01,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 269496320 22:56:01 INFO - 2015-11-17 22:56:01,408 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,408 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:56:01 INFO - 2015-11-17 22:56:01,409 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:56:01 INFO - 2015-11-17 22:56:01,409 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:56:01 INFO - 2015-11-17 22:56:01,409 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:56:01 INFO - 2015-11-17 22:56:01,409 DEBUG : BROWSER_OUTPUT: |0;ai-astar;127;126;135;134;134;140;128;134;133;134 22:56:01 INFO - 2015-11-17 22:56:01,409 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;177;163;182;211;158;180;177;196;194;160 22:56:01 INFO - 2015-11-17 22:56:01,409 DEBUG : BROWSER_OUTPUT: |2;audio-dft;191;202;213;200;199;193;193;192;206;198 22:56:01 INFO - 2015-11-17 22:56:01,409 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;89;100;144;80;85;85;85;117;81 22:56:01 INFO - 2015-11-17 22:56:01,410 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;103;105;154;107;111;110;143;105;105;154 22:56:01 INFO - 2015-11-17 22:56:01,410 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;143;136;150;149;143;149;150;142;143 22:56:01 INFO - 2015-11-17 22:56:01,410 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;157;156;158;154;150;156;156;154;150;156 22:56:01 INFO - 2015-11-17 22:56:01,410 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;120;127;117;130;119;118;117;117;123;134 22:56:01 INFO - 2015-11-17 22:56:01,410 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;78;75;75;77;81;80;80;85;78;79 22:56:01 INFO - 2015-11-17 22:56:01,410 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;81;83;82;87;87;88;87;85;86;87 22:56:01 INFO - 2015-11-17 22:56:01,410 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;103;110;109;107;110;109;106;109;108;104 22:56:01 INFO - 2015-11-17 22:56:01,410 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;162;169;155;151;157;164;152;155;155;155 22:56:01 INFO - 2015-11-17 22:56:01,411 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;186;193;192;189;185;185;194;189;188;174 22:56:01 INFO - 2015-11-17 22:56:01,411 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;81;84;90;89;91;88;89;88;87;88 22:56:01 INFO - 2015-11-17 22:56:01,411 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:56:01 INFO - 2015-11-17 22:56:01,411 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:56:01 INFO - 2015-11-17 22:56:01,411 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,741 22:56:01 INFO - 2015-11-17 22:56:01,411 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:56:01 INFO - 2015-11-17 22:56:01,411 DEBUG : BROWSER_OUTPUT: __startTimestamp1447829761402__endTimestamp 22:56:01 INFO - 2015-11-17 22:56:01,412 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,412 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:56:01 INFO - 2015-11-17 22:56:01,412 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:56:01 INFO - 2015-11-17 22:56:01,412 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,412 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:132.50 Median:134.00 stddev:4.28 (3.2%) stddev-sans-first:4.04 22:56:01 INFO - 2015-11-17 22:56:01,412 DEBUG : BROWSER_OUTPUT: Values: 127.0 126.0 135.0 134.0 134.0 140.0 128.0 134.0 133.0 134.0 22:56:01 INFO - 2015-11-17 22:56:01,412 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,412 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:179.80 Median:181.00 stddev:17.02 (9.4%) stddev-sans-first:18.02 22:56:01 INFO - 2015-11-17 22:56:01,413 DEBUG : BROWSER_OUTPUT: Values: 177.0 163.0 182.0 211.0 158.0 180.0 177.0 196.0 194.0 160.0 22:56:01 INFO - 2015-11-17 22:56:01,413 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,413 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:198.70 Median:199.50 stddev:6.99 (3.5%) stddev-sans-first:6.84 22:56:01 INFO - 2015-11-17 22:56:01,413 DEBUG : BROWSER_OUTPUT: Values: 191.0 202.0 213.0 200.0 199.0 193.0 193.0 192.0 206.0 198.0 22:56:01 INFO - 2015-11-17 22:56:01,413 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,413 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:94.70 Median:83.00 stddev:20.72 (25.0%) stddev-sans-first:21.37 22:56:01 INFO - 2015-11-17 22:56:01,413 DEBUG : BROWSER_OUTPUT: Values: 81.0 89.0 100.0 144.0 80.0 85.0 85.0 85.0 117.0 81.0 22:56:01 INFO - 2015-11-17 22:56:01,413 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:119.70 Median:110.50 stddev:21.48 (19.4%) stddev-sans-first:21.92 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: Values: 103.0 105.0 154.0 107.0 111.0 110.0 143.0 105.0 105.0 154.0 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:145.40 Median:149.00 stddev:4.70 (3.2%) stddev-sans-first:4.80 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: Values: 149.0 143.0 136.0 150.0 149.0 143.0 149.0 150.0 142.0 143.0 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:154.70 Median:156.00 stddev:2.75 (1.8%) stddev-sans-first:2.79 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: Values: 157.0 156.0 158.0 154.0 150.0 156.0 156.0 154.0 150.0 156.0 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:122.20 Median:121.50 stddev:6.12 (5.0%) stddev-sans-first:6.44 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: Values: 120.0 127.0 117.0 130.0 119.0 118.0 117.0 117.0 123.0 134.0 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,414 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:78.80 Median:79.50 stddev:2.97 (3.7%) stddev-sans-first:3.14 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: Values: 78.0 75.0 75.0 77.0 81.0 80.0 80.0 85.0 78.0 79.0 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:85.30 Median:87.00 stddev:2.45 (2.8%) stddev-sans-first:2.05 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 82.0 87.0 87.0 88.0 87.0 85.0 86.0 87.0 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:107.50 Median:109.00 stddev:2.46 (2.3%) stddev-sans-first:2.00 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: Values: 103.0 110.0 109.0 107.0 110.0 109.0 106.0 109.0 108.0 104.0 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:157.50 Median:156.00 stddev:5.70 (3.7%) stddev-sans-first:5.81 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: Values: 162.0 169.0 155.0 151.0 157.0 164.0 152.0 155.0 155.0 155.0 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.50 Median:189.00 stddev:5.72 (3.0%) stddev-sans-first:6.04 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: Values: 186.0 193.0 192.0 189.0 185.0 185.0 194.0 189.0 188.0 174.0 22:56:01 INFO - 2015-11-17 22:56:01,415 DEBUG : BROWSER_OUTPUT: 22:56:01 INFO - 2015-11-17 22:56:01,416 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.50 Median:88.50 stddev:2.95 (3.3%) stddev-sans-first:1.99 22:56:01 INFO - 2015-11-17 22:56:01,416 DEBUG : BROWSER_OUTPUT: Values: 81.0 84.0 90.0 89.0 91.0 88.0 89.0 88.0 87.0 88.0 22:56:01 INFO - 2015-11-17 22:56:01,416 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:56:01 INFO - 2015-11-17 22:56:01,416 DEBUG : BROWSER_OUTPUT: 22:56:02 INFO - 2015-11-17 22:56:02,159 INFO : Browser exited with error code: 0 22:56:02 INFO - 2015-11-17 22:56:02,213 INFO : Completed test kraken (00:01:02) 22:56:02 INFO - 2015-11-17 22:56:02,213 INFO : Starting test v8_7 22:56:02 INFO - 2015-11-17 22:56:02,213 DEBUG : operating with platform_type : mac_ 22:56:02 INFO - 2015-11-17 22:56:02,213 INFO : Initialising browser for v8_7 test... 22:56:02 INFO - 2015-11-17 22:56:02,228 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpbIMZDK/profile http://localhost:49263/getInfo.html 22:56:05 INFO - 2015-11-17 22:56:05,336 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:56:05 INFO - 2015-11-17 22:56:05,336 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:56:05 INFO - 2015-11-17 22:56:05,336 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:56:05 INFO - 2015-11-17 22:56:05,336 DEBUG : BROWSER_OUTPUT: __metrics 22:56:06 INFO - 2015-11-17 22:56:06,068 INFO : Browser initialized. 22:56:06 INFO - 2015-11-17 22:56:06,068 INFO : Running cycle 1/1 for v8_7 test... 22:56:06 INFO - 2015-11-17 22:56:06,068 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/T/tmpbIMZDK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:56:18 INFO - 2015-11-17 22:56:18,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 240017408 22:56:18 INFO - 2015-11-17 22:56:18,211 DEBUG : BROWSER_OUTPUT: 22:56:40 INFO - 2015-11-17 22:56:40,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/v8_7/run.html (next: http://localhost:49263/tests/v8_7/run.html) 22:56:41 INFO - 2015-11-17 22:56:41,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 260489216 22:56:41 INFO - 2015-11-17 22:56:41,066 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,066 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:56:41 INFO - 2015-11-17 22:56:41,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:56:41 INFO - 2015-11-17 22:56:41,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:56:41 INFO - 2015-11-17 22:56:41,066 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:56:41 INFO - 2015-11-17 22:56:41,066 DEBUG : BROWSER_OUTPUT: |0;Richards;203.3760423022168 22:56:41 INFO - 2015-11-17 22:56:41,067 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;230.62730627306274 22:56:41 INFO - 2015-11-17 22:56:41,067 DEBUG : BROWSER_OUTPUT: |2;Encrypt;372.0238095238095 22:56:41 INFO - 2015-11-17 22:56:41,067 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6829.931972789115 22:56:41 INFO - 2015-11-17 22:56:41,067 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1305.4830287206266 22:56:41 INFO - 2015-11-17 22:56:41,067 DEBUG : BROWSER_OUTPUT: |5;Earley;1088.139281828074 22:56:41 INFO - 2015-11-17 22:56:41,067 DEBUG : BROWSER_OUTPUT: |6;Boyer;15164.179104477613 22:56:41 INFO - 2015-11-17 22:56:41,068 DEBUG : BROWSER_OUTPUT: |7;RegExp;34457.627118644064 22:56:41 INFO - 2015-11-17 22:56:41,068 DEBUG : BROWSER_OUTPUT: |8;Splay;827.9569892473119 22:56:41 INFO - 2015-11-17 22:56:41,068 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6718.120805369127 22:56:41 INFO - 2015-11-17 22:56:41,068 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:56:41 INFO - 2015-11-17 22:56:41,068 DEBUG : BROWSER_OUTPUT: __startTimestamp1447829801065__endTimestamp 22:56:41 INFO - 2015-11-17 22:56:41,068 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,068 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:56:41 INFO - 2015-11-17 22:56:41,068 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:56:41 INFO - 2015-11-17 22:56:41,070 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,070 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:203.38 Median:203.38 stddev:0.00 (0.0%) 22:56:41 INFO - 2015-11-17 22:56:41,070 DEBUG : BROWSER_OUTPUT: Values: 203.4 22:56:41 INFO - 2015-11-17 22:56:41,070 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,070 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:230.63 Median:230.63 stddev:0.00 (0.0%) 22:56:41 INFO - 2015-11-17 22:56:41,070 DEBUG : BROWSER_OUTPUT: Values: 230.6 22:56:41 INFO - 2015-11-17 22:56:41,071 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,071 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:372.02 Median:372.02 stddev:0.00 (0.0%) 22:56:41 INFO - 2015-11-17 22:56:41,071 DEBUG : BROWSER_OUTPUT: Values: 372.0 22:56:41 INFO - 2015-11-17 22:56:41,071 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,071 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6829.93 Median:6829.93 stddev:0.00 (0.0%) 22:56:41 INFO - 2015-11-17 22:56:41,071 DEBUG : BROWSER_OUTPUT: Values: 6829.9 22:56:41 INFO - 2015-11-17 22:56:41,071 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,071 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1305.48 Median:1305.48 stddev:0.00 (0.0%) 22:56:41 INFO - 2015-11-17 22:56:41,071 DEBUG : BROWSER_OUTPUT: Values: 1305.5 22:56:41 INFO - 2015-11-17 22:56:41,072 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,072 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1088.14 Median:1088.14 stddev:0.00 (0.0%) 22:56:41 INFO - 2015-11-17 22:56:41,072 DEBUG : BROWSER_OUTPUT: Values: 1088.1 22:56:41 INFO - 2015-11-17 22:56:41,072 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,072 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15164.18 Median:15164.18 stddev:0.00 (0.0%) 22:56:41 INFO - 2015-11-17 22:56:41,072 DEBUG : BROWSER_OUTPUT: Values: 15164.2 22:56:41 INFO - 2015-11-17 22:56:41,073 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,073 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34457.63 Median:34457.63 stddev:0.00 (0.0%) 22:56:41 INFO - 2015-11-17 22:56:41,073 DEBUG : BROWSER_OUTPUT: Values: 34457.6 22:56:41 INFO - 2015-11-17 22:56:41,073 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,073 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:827.96 Median:827.96 stddev:0.00 (0.0%) 22:56:41 INFO - 2015-11-17 22:56:41,073 DEBUG : BROWSER_OUTPUT: Values: 828.0 22:56:41 INFO - 2015-11-17 22:56:41,073 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,073 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6718.12 Median:6718.12 stddev:0.00 (0.0%) 22:56:41 INFO - 2015-11-17 22:56:41,073 DEBUG : BROWSER_OUTPUT: Values: 6718.1 22:56:41 INFO - 2015-11-17 22:56:41,074 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:56:41 INFO - 2015-11-17 22:56:41,074 DEBUG : BROWSER_OUTPUT: 22:56:41 INFO - 2015-11-17 22:56:41,770 INFO : Browser exited with error code: 0 22:56:41 INFO - 2015-11-17 22:56:41,792 INFO : Completed test v8_7 (00:00:39) 22:56:42 INFO - 2015-11-17 22:56:42,040 INFO : Completed test suite (00:20:15) 22:56:42 INFO - 2015-11-17 22:56:42,040 DEBUG : Working with test: dromaeo_css 22:56:42 INFO - 2015-11-17 22:56:42,040 DEBUG : Generating results file: dromaeo_css 22:56:42 INFO - 2015-11-17 22:56:42,041 DEBUG : Working with test: kraken 22:56:42 INFO - 2015-11-17 22:56:42,041 DEBUG : Generating results file: kraken 22:56:42 INFO - 2015-11-17 22:56:42,041 INFO : javascript benchmark 22:56:42 INFO - 2015-11-17 22:56:42,041 DEBUG : Working with test: v8_7 22:56:42 INFO - 2015-11-17 22:56:42,041 DEBUG : Generating results file: v8_7 22:56:42 INFO - 2015-11-17 22:56:42,041 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:56:42 INFO - 2015-11-17 22:56:42,093 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 22:56:42 INFO - 2015-11-17 22:56:42,093 DEBUG : process_Request line: dromaeo_css 5736.59 graph.html#tests=[[72,64,57]] 22:56:42 INFO - 2015-11-17 22:56:42,093 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:56:42 INFO - 2015-11-17 22:56:42,123 DEBUG : process_Request line: kraken 1851.80 graph.html#tests=[[232,64,57]] 22:56:42 INFO - 2015-11-17 22:56:42,123 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:56:42 INFO - 2015-11-17 22:56:42,159 DEBUG : process_Request line: v8_7 16247.94 graph.html#tests=[[230,64,57]] 22:56:42 INFO - 2015-11-17 22:56:42,160 INFO : javascript benchmark 22:56:42 INFO - 2015-11-17 22:56:42,162 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [291.43607120222356, 291.6631290859057, 291.82927987127516, 294.6817437167859, 301.09670987038885, 12536.435860386282, 12777.872221277785, 14627.488037918662, 14997.933688838422, 15158.0, 15242.314095865684, 15257.847421525781, 16319.755203671924, 16346.754798678, 16434.260458279376, 4088.632023117919, 4168.0413504893895, 4185.874423767276, 4186.37204419338, 4639.234526303156, 4005.2390045891334, 4128.422020917074, 4137.027798467373, 4161.563035881234, 4182.372644103379, 4072.5316588592395, 4076.4496792932873, 4094.61101195386, 4094.651954583864, 4095.201435720036, 4041.7574945503216, 4207.810648520794, 4222.19778242133, 4224.429701990253, 4243.08773613673, 3555.2178520725397, 3570.80360580168, 3572.1069732566857, 3579.3378225028455, 3587.1570181007705, 11214.831777523344, 11337.603183888525, 11523.827142592867, 11562.653120406401, 11571.94214028933, 1547.3114464063497, 1589.9364025438967, 1593.6573636668172, 1604.5908293385228, 1655.0897006646417, 8270.503769773773, 8337.708180213724, 8452.408331416804, 8550.273226775731, 8671.21959023691, 1316.795896636023, 1322.8409204103975, 1351.229799014562, 1407.0030834322827, 1409.0981771666143, 49855.750721246164, 51428.74285628548, 51609.0, 51994.48005519972, 52373.0, 5550.250716153349, 5580.497755202051, 5588.832335029955, 5684.033714268584, 5686.118651608925, 6449.419552240321, 6457.903131453032, 6463.192100987377, 6471.611703297817, 6486.772962946275, 4714.127886340969, 4752.928706069411, 4802.927956080662, 4815.903681926342, 4834.7824347904425, 5024.62315326352, 5137.743112844343, 5156.278121063054, 5198.090334191501, 5213.452587478336, 2509.4102885821817, 2511.4098186926058, 2522.621606758964, 2525.0783464035494, 2531.7847982921658, 878.6836738774036, 894.4856707393275, 930.5114814722325, 947.2469386837481, 965.3290962780941, 366.8734286671094, 373.44729799895765, 374.8200863585494, 380.1882979838066, 405.97491334380925, 9786.51067446639, 10253.282270241012, 10282.948585257176, 10407.47962601882, 10419.42693151884, 385.96333348331865, 393.15079428434444, 401.83524754850373, 402.2196937940386, 408.3242234102565, 5275.3142091528625, 5392.272043274186, 5666.603337766399, 5673.971630141823, 5730.455606717355, 457554.0, 462695.0, 467569.0, 470190.0, 475776.0, 62849.371506284355, 63675.36324636694, 64835.0, 64981.675091625184, 65622.34377656257, 426.63096421595094, 433.5361163555029, 434.12307139577877, 437.81611723076384, 442.5530214483395, 9242.399244049115, 9531.285153613368, 9561.139497445263, 9569.569369378256, 9615.086566776145, 28802.27994300159, 29504.262393440335, 30188.09435716932, 30306.242343941576, 31090.37819243557, 38575.22849543049, 38991.805040974614, 39136.608633913296, 39171.41242881416, 39926.80036599799, 5241.135212689864, 5411.567074633941, 5428.077226871363, 5440.102383106743, 5445.373782015119, 9875.506224688594, 10085.69742907714, 10332.586696532055, 10349.0, 10377.688669339932, 8420.11588783169, 8679.869801953102, 8828.117188281121, 8863.290936725176, 8923.553822308988, 8525.44584601999, 8543.145685431407, 8585.699500517452, 8594.527300998505, 8856.512891791013, 8836.381453298465, 8841.204291613785, 8858.202761751474, 9054.049324820799, 9143.26853851677, 5345.251664766858, 5403.675779453245, 5407.945920540744, 5416.8104116355735, 5448.073827449422, 8833.602487887933, 8856.291496680378, 8987.0, 9002.099790020946, 9021.052789457013], "dojo.html": [2708.6072519484674, 2733.466973940081, 2740.1916434651775, 2812.535931571291, 2819.1401622505127, 4634.513376095512, 4645.55867192617, 4666.48668646449, 4755.785989630466, 4770.141374552583, 4536.1381337545845, 4554.20301447247, 4608.423947006624, 4621.329907163467, 4765.166095933215, 4224.049588842517, 4276.657867370618, 4302.419173411597, 4355.063661312817, 4371.082072764707, 4255.893602659928, 4277.529471758104, 4280.6361459275995, 4322.308430651096, 4366.868993930188, 4090.5909409059154, 4165.208610364021, 4257.254980378421, 4282.357646353056, 4306.892327691833, 4276.422682937795, 4302.376155457472, 4327.935080973788, 4345.826166953318, 4376.496702879178, 4281.464816897887, 4291.334843099325, 4349.238883195429, 4352.934705979413, 4399.318105693623, 4423.8672839814535, 4449.822007119711, 4564.566366195206, 4663.230566956482, 4666.066786642685, 4995.125852975751, 5016.54851063406, 5032.723200223986, 5047.268146118792, 5091.1090559152, 4821.662483626147, 5045.318881950926, 5058.974705126451, 5094.465081166498, 5162.974185129088, 4567.748773817472, 4580.519045500175, 4602.631789456836, 4660.464046634646, 4722.362481065013, 5156.226566015128, 5165.690058596496, 5188.092083885305, 5193.844184674465, 5219.295395121686, 4754.857354279377, 4799.66402351832, 4964.801407943714, 4973.751312434364, 4982.377202849644, 4870.634702397264, 4971.801127954914, 4983.202687569971, 5027.245913112989, 5077.060743762416, 4916.2625606158645, 4965.702057876539, 5015.573676237561, 5046.949530504721, 5083.161278389099, 4774.427068751772, 4830.541098595628, 4873.342098816685, 4964.230544265644, 5105.208692652571, 3836.0, 3846.5961074087377, 3890.6692931101175, 3903.726739128291, 3945.0, 3517.402041652925, 3533.4169861972487, 3546.361654902142, 3566.0906468850276, 3589.4615807629066, 4537.342085397599, 4637.976810115928, 4697.412823397075, 4798.2322828348, 4888.877778055577, 5067.797288108434, 5098.056859481007, 5105.412877519058, 5157.123289040872, 5161.458046905096, 4759.928601070987, 4774.809007639656, 4775.140474714584, 4814.6870453420415, 4862.586680132228, 4251.4685664291965, 4308.073764140662, 4317.805698743564, 4356.063446359048, 4422.977885110618, 5208.869778255574, 5229.973850130725, 5254.500822421864, 5301.284326616012, 5347.786088556492, 4889.755512224446, 5078.466760990191, 5123.538881500683, 5137.229415587692, 5171.870703232299, 5097.464766199496, 5150.201718733602, 5189.091908916, 5199.0, 5266.762995665281, 4947.2579113133315, 4963.0, 4971.353724015855, 5008.048470790538, 5080.618953578422, 4761.880952976203, 4923.8276660316715, 5041.218611115283, 5069.9746501267255, 5070.112730272114, 4818.71087734737, 4846.369971903771, 4888.437829649636, 4889.3888263967, 4949.084419382426, 4891.217405215149, 4950.059488697136, 4955.702657840541, 4958.603311735124, 4968.22992436173, 4293.119910418294, 4567.771611419349, 4754.358161648133, 4846.365723792014, 4907.877303067309, 4952.158133117451, 4971.229459433794, 4990.8253211137435, 5006.199008158677, 5022.196448568212, 4879.048585525788, 4884.291777692286, 4947.554720075211, 4958.404991401055, 4989.850304490871], "mootools.html": [1193.5404869125389, 1194.4624918786546, 1236.6351926181776, 1550.232634845751, 1564.2178910544728, 5677.886442271152, 5720.856978575538, 6350.396712312328, 6702.832429189267, 6710.0, 6334.524910631698, 6360.300366959642, 6456.418922296993, 6465.547411681184, 6466.579672321296, 1920.6350793349254, 1930.94207173785, 1959.9902000489978, 1962.2641509433963, 1963.0184907546227, 1983.4545499987476, 1986.8211860932513, 1998.6202621501868, 2015.0730663894626, 2022.413500084981, 1946.776120746111, 1976.4663540843962, 1976.9406917792417, 2005.147812179825, 2005.2981456490186, 1947.552063025512, 1950.2101648832245, 1951.6877299632063, 1960.2942940541536, 1977.8714383565166, 1949.220311875247, 1962.4112766170235, 1992.7608686957512, 1992.950176245591, 2011.597680463913, 6343.0, 6454.22549294083, 6474.7086381112495, 6476.8704625907685, 6504.60972341661, 4015.2371049500503, 4097.569755175693, 4153.584641535853, 4159.396887451333, 4177.0, 2239.921602743896, 2302.470431800695, 2507.761762632547, 2569.486102779452, 2606.2832721001687, 782.7360997293215, 792.8691765858626, 815.9061707903548, 819.9262066413992, 833.2209384225769, 8304.875426868603, 8334.958325208396, 8363.874541881876, 8367.790805229857, 8427.536485493296, 3758.4550240215017, 3775.2638235543805, 3874.593167717349, 3890.105275786585, 3895.4935858338235, 7314.195438501761, 7334.66993985272, 7361.595112268769, 7370.8894366584545, 7383.2616738326815, 4183.853565125206, 4197.496300443966, 4201.957980420218, 4219.282721937278, 4221.451211342506, 3770.9434358484646, 3790.3177428063213, 3799.848006079781, 3818.8281527331337, 3835.347990841564, 3120.8595613197463, 3132.5144602586633, 3142.261568531393, 3183.602049743782, 3187.282861356223, 1063.6436793674052, 1074.7044562745152, 1079.438691880218, 1085.2240647936605, 1089.2320913755784, 900.5092224737534, 902.5306840443064, 903.1555495611493, 917.8990311065777, 1112.5494174859195, 6021.548383871227, 6038.426349496791, 6044.727987240584, 6083.847903802441, 6092.543059270483, 403.50772058089086, 415.56988516885485, 417.83077853469393, 421.8207261913736, 423.93217085266207, 4788.592969597623, 4799.352087468217, 4805.399325084364, 4836.322914791932, 4849.515048495122, 6934.098567186335, 7198.604076775723, 7368.115826100902, 7395.963020184865, 7584.165741768401, 7424.294692004359, 7438.256174382518, 7492.213317601682, 7500.662470188855, 7528.736494222676, 5968.880622387528, 5996.67018313997, 6013.308469525973, 6080.361562036011, 6139.6009259398, 5765.827025189251, 5768.682722450306, 5840.123981402823, 5843.94156058434, 5845.357010728731, 6594.175728033996, 6664.300248474035, 6729.596224226562, 6737.023131645786, 6841.3842754152365, 6868.62222577763, 6940.063091482585, 6992.4406047517095, 7003.719851206099, 7043.049188359506, 5490.588205884655, 5526.392096869422, 5601.775928962796, 5614.915776263441, 5616.129499927518, 6008.66882891466, 6056.818295451144, 6087.0565062413625, 6142.600730952474, 6143.109249158936, 5704.857378565569, 5770.596058275881, 5807.477327040587, 5827.388124246893, 5904.439078287556, 5629.099344104923, 5695.088785794419, 5740.971295143498, 5795.82612521625, 5811.244538210006, 5770.336411312753, 5812.099124635688, 5817.040188368872, 5834.766609335748, 5854.121881717776, 5216.765245563883, 5236.319278493771, 5351.1973204019705, 5351.384590771955, 5363.168708850135, 5251.474852514718, 5392.191171324333, 5408.513233808976, 5455.5908306876345, 5472.91790623133], "ext.html": [483.56237604967515, 485.3981063481283, 503.5694481218557, 513.1276829390038, 513.2301547678483, 34088.31823363531, 35060.474092888566, 35214.47178292325, 35342.82328588353, 35485.11287217821, 36710.816445917735, 37646.4353034704, 37672.623273767254, 37696.81151594245, 37760.62239377605, 7983.241592048761, 8063.435559510807, 8112.878306825402, 8155.469894456842, 8195.0, 7916.525008499509, 8032.759017229492, 8055.154208808079, 8065.556394398306, 8070.435069545134, 7932.325752311061, 7947.324477419397, 8030.638621262057, 8031.955845740045, 8048.195180481964, 7944.165862584432, 8038.959805200995, 8123.431359804816, 8124.878126828103, 8130.593470326519, 7664.923350766477, 7822.882656760153, 7888.526688398657, 7940.483868548526, 7959.920400795976, 34689.132771680655, 34760.82619586886, 34833.129171770655, 35057.29885402303, 35287.0, 2651.2443953473166, 2675.2108128102063, 2680.4505076459277, 2743.0810678422754, 3017.6982301769867, 23533.529329413486, 23933.64099538508, 24118.2764517063, 24751.752482475305, 25394.36514087144, 2053.7946205379494, 2068.2317612783363, 2091.362134548962, 2120.3003009007143, 2178.836587255946, 221403.0, 225816.0, 225916.8704156485, 226294.0, 226618.0, 44534.0, 45572.54427455683, 50666.74666626717, 51269.743651281504, 53120.734396327774, 47338.763306183246, 47723.28415073777, 47850.5214947846, 47949.760251199215, 48162.0, 14063.156210627396, 14098.718025639635, 14112.788308175386, 14302.0, 14303.713925721635, 10523.684289471328, 10733.409662468639, 10769.407682577534, 10781.730456738644, 10793.136549076055, 16965.321387144624, 17132.828671713374, 17133.22900469482, 17318.0, 17353.65292694139, 6875.48433867462, 7085.610291434021, 7112.6443677815905, 7135.357817796424, 7154.964225178945, 806.3106044332012, 813.60540138033, 859.9656013759379, 926.967556135532, 938.77000134966, 24581.87709061443, 24903.129139647754, 25144.874275628506, 25170.496590068095, 25604.74395256061, 909.2816674826945, 978.2467500024941, 989.4162444157981, 1041.6406339812752, 1082.437132691012, 12998.220106793622, 13106.279154646585, 13135.211887286794, 13204.537841175705, 13378.665533361744, 248895.0, 251222.0, 253624.0, 255194.0, 258737.0, 46650.76674616605, 46883.0, 46983.29525057127, 47102.0, 47152.52847471481, 1188.2751521571834, 1205.2406983600276, 1206.704357432417, 1215.9088068394728, 1218.2629509147016, 24241.15155969603, 24924.252272431855, 25147.622785657863, 25153.0, 25172.74827251704, 40863.0, 41206.38190427206, 41446.0, 41505.1698966025, 41515.0, 236477.0, 239193.0, 239275.0, 239877.0, 240443.0, 27094.458110838066, 27397.45205095847, 27854.721452785212, 27918.581221281293, 28120.0, 32733.672663274014, 33062.33875322432, 33213.0, 33416.0, 33703.0, 28496.145115646563, 28769.56845647359, 28936.56595151032, 28978.13065608035, 28978.710212898444, 28298.43403131967, 29068.12795616135, 30459.390812184076, 30801.383972320877, 31019.84490077535, 30823.53764693576, 30902.53646195354, 31109.377812444076, 31160.220994474414, 31350.843245784537, 25771.355716107246, 26509.204723857543, 28763.85618071896, 28795.42409151847, 29007.41985160327, 20609.94928713044, 20832.895835521333, 20979.160833567097, 21032.579348413252, 21057.47356316043], "prototype.html": [269.3186238815796, 274.4716420889787, 280.8174686453805, 282.25906994140394, 283.1491368437844, 5263.578913686905, 5362.490563396481, 5491.725413729312, 5526.143447765598, 5565.638233514819, 5446.373667028293, 5472.042392581292, 5499.890002199953, 5526.972365138168, 5574.358948720898, 4192.643625291838, 4214.852480163195, 4232.195882782277, 4251.277282861905, 4253.2131555662145, 4168.333066709327, 4236.983124050236, 4246.299360605496, 4247.384129301249, 4260.211860805745, 4146.502419709639, 4171.937420938689, 4195.202911446815, 4209.0, 4210.473690788652, 4034.3141665916864, 4133.111381053073, 4182.728122672017, 4188.099558594886, 4196.916061678779, 3534.6995505382074, 3592.4431713084514, 3593.1196856770257, 3604.9279014419567, 3605.603383627799, 5410.756515956791, 5416.21464887593, 5422.864428389283, 5439.918401223985, 5469.234307196995, 4686.343911852309, 4715.622750180011, 4763.071201115784, 4771.28430735389, 4781.330613714083, 5590.18942253371, 5701.486866182064, 5735.942640573582, 5871.500922421599, 5879.265091863517, 3774.9433758493647, 3791.6777073948747, 3799.810009499514, 3819.4079917612817, 3849.30712471755, 5907.645541267538, 6018.909716354258, 6104.2980057293535, 6112.235970503687, 6131.724072416752, 3865.420186971977, 3867.207222519377, 3892.766434013968, 3916.6083391660604, 3922.941155882664, 3942.8817135485983, 3996.100877302642, 3998.7600743955454, 4000.4799376081505, 4009.1179940413062, 4640.141573808856, 4660.347551342815, 4673.696209746356, 4682.321063445849, 4697.0, 5613.0, 5787.0, 5802.274715660543, 5812.59311848175, 5827.650340979555, 1378.7862881253423, 1381.081580748811, 1384.6469150366793, 1403.3264033263886, 1412.7033323002079, 897.9012308646044, 901.1799262670938, 902.4224496322358, 908.4367692030983, 912.7535565397438, 5528.198411230349, 5558.166275058774, 5588.3573389060775, 5611.410801865827, 5628.97185514078, 6022.156898034279, 6049.18336024631, 6066.787662431793, 6079.8480037998515, 6093.96953015241, 5547.583931205176, 5560.0, 5575.275214222206, 5578.414266501959, 5612.663240205601, 3191.505316675919, 3242.0760083376126, 3268.313654132611, 3299.1257316811066, 3301.4882693182117, 6201.286852011986, 6218.844528886814, 6220.160278362454, 6225.28409232944, 6232.594881332699, 6164.506839452833, 6166.506679465632, 6199.380061993765, 6217.720202590804, 6222.222222222223, 6030.969845150747, 6135.877282454415, 6215.595986260879, 6230.657313847782, 6240.65676387794, 6061.333253342217, 6065.6663883486835, 6074.665893375906, 6078.908816367846, 6085.300190478151, 5880.441358070976, 5888.263967004124, 5896.616719913192, 5898.970505147447, 5914.408559144224, 6217.844553886189, 6224.906626400517, 6246.875062498815, 6254.3745625437095, 6262.185915830913, 3920.2159568085926, 3944.211157768515, 3954.5452272988973, 3965.4250133731025, 3969.8015099244344, 6100.328963814066, 6101.694915254131, 6102.786402475892, 6115.6330620162935, 6132.938670613236, 5892.734826932884, 5931.110333450017, 5956.583039187215, 5958.165856779968, 5972.193753843176, 5763.9135412968, 5821.854453638693, 5834.912476312774, 5931.525477961839, 5941.346451890202, 5723.170140329712, 5757.971210143923, 5758.193852860519, 5764.048931926185, 5764.827055188351, 5853.531717462508, 5921.467067963904, 5928.229330187048, 5936.079907614327, 5956.880862382642, 5593.300837395325, 5780.7398667060925, 5804.01331773591, 5815.185873977562, 5858.765649373977], "yui.html": [572.1169815623653, 605.6063558686853, 607.696151924038, 651.1535004494158, 662.7282814046242, 11830.349330786803, 12021.819672704916, 12233.143679942408, 12238.938805305972, 12256.26462412256, 10593.470326483664, 11383.886161138385, 11511.194216404854, 12316.0, 12327.260364378144, 748.4760667532735, 757.685560492395, 757.8825282081286, 758.2985738192177, 760.1334478694293, 747.2154238050053, 750.3097150621414, 761.958092304923, 762.2453770766929, 766.2529034191674, 792.1286584756779, 792.1998781230941, 800.8718605023197, 802.3701394405393, 803.4576660753997, 784.8548018616546, 791.9881201781977, 794.5629903553023, 795.6340083561511, 798.5448294472153, 585.125237769533, 590.2238556298497, 590.6249531547455, 592.5259792166249, 593.3325009364465, 11706.53173873044, 11900.107491938139, 11904.285742855456, 11925.761484770343, 12024.218425802295, 9772.26707996896, 9955.651552195712, 10140.08739213467, 10179.389236645826, 10466.267361284714, 7878.123651728015, 8131.59342032896, 8200.220979007045, 8246.422750407473, 8253.669853205865, 2832.5609530522597, 2868.584055311989, 2887.4946884295373, 2933.346528774317, 2959.482090634152, 38276.61723382759, 38543.807280963694, 39743.8012809937, 41632.167356653, 42634.360484592755, 7848.13670496245, 7865.331446827084, 7889.447738658354, 7890.684372625031, 7902.24928631779, 16612.750808737877, 16639.50081497557, 16640.6671866562, 16647.83352166487, 16690.49928502147, 5766.798162064308, 5770.798022069292, 6055.061465472859, 6078.483328917092, 6120.418560236771, 3363.680450357212, 3402.897913062612, 3407.6762707542744, 3489.0753950203216, 3553.7867727936405, 2570.3445621366805, 2593.5072336256053, 2594.338443696883, 2597.142942828862, 2599.4671092426006, 378.60624950052187, 380.3894748927931, 382.8526017483289, 387.97090218233745, 390.1358490942576, 405.54578871663927, 440.3153096934298, 448.91021795640347, 491.68286455236887, 553.1674829381835, 6361.083259755865, 7143.285671432919, 7162.212156662763, 7479.401647868158, 7647.847043059108, 432.93505974103505, 495.20519566095896, 495.3671237373349, 504.4325134223998, 525.511274514705, 3264.7061764441314, 3282.950755738666, 3365.1082463147286, 3401.8809341672923, 3461.463473161664, 51861.48138518642, 51931.740341298806, 51942.22086668703, 52268.21597676038, 52619.73690131525, 44086.77956610196, 44954.77522612366, 45021.32468012982, 45044.549554504694, 45541.772291138994, 38624.613753862664, 41641.167176656905, 41734.0, 42758.78620606877, 42940.78529607395, 6752.189737231563, 7033.9296607033275, 7150.0, 7372.189059203591, 7410.0, 30904.381912362078, 31436.371272573964, 31502.842485787423, 31993.0, 32045.51931721073, 36524.086897827765, 37860.432093518066, 38990.0, 41001.79499102486, 41215.175696486505, 6186.19579454668, 6266.655333956493, 6316.0, 6361.936380636134, 6428.132202152649, 9176.862347064665, 9232.122948319899, 9239.953800230956, 9307.0, 9423.905760942303, 8793.340499462438, 8809.779755505908, 8923.821523569623, 8927.955360223157, 9100.36297459198, 9266.351355405057, 9282.35023548345, 9311.906880931105, 9312.34813563044, 9392.248620110238, 8637.253246172835, 8703.825923481621, 8944.955275223581, 8975.640974360953, 9013.729588112366, 7652.617369131633, 7659.348955338635, 7920.801979950547, 8335.999680038434, 8402.0, 7421.777346679608, 7630.351420129351, 7751.651175696994, 8017.639206235617, 8106.513609183467]}, "summary": {"lowerIsBetter": false, "suite": 5736.585038906617, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5827.410535571936, "unit": "ms", "value": 5827.410535571936}, "dojo.html": {"lowerIsBetter": false, "filtered": 4636.285093623908, "unit": "ms", "value": 4636.285093623908}, "mootools.html": {"lowerIsBetter": false, "filtered": 3669.612131218272, "unit": "ms", "value": 3669.612131218272}, "ext.html": {"lowerIsBetter": false, "filtered": 15829.907068142482, "unit": "ms", "value": 15829.907068142482}, "prototype.html": {"lowerIsBetter": false, "filtered": 4342.021588308513, "unit": "ms", "value": 4342.021588308513}, "yui.html": {"lowerIsBetter": false, "filtered": 5229.275894543651, "unit": "ms", "value": 5229.275894543651}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0054.e"}, "testrun": {"date": 1447828586, "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": "20151117210240", "branch": "Fx-Team", "revision": "fb5b48c3abe6dc120cde93464372d2bf9095a7a2"}}, {"talos_counters": {}, "results": {"audio-dft": [191.0, 202.0, 213.0, 200.0, 199.0, 193.0, 193.0, 192.0, 206.0, 198.0], "ai-astar": [127.0, 126.0, 135.0, 134.0, 134.0, 140.0, 128.0, 134.0, 133.0, 134.0], "imaging-gaussian-blur": [149.0, 143.0, 136.0, 150.0, 149.0, 143.0, 149.0, 150.0, 142.0, 143.0], "audio-beat-detection": [177.0, 163.0, 182.0, 211.0, 158.0, 180.0, 177.0, 196.0, 194.0, 160.0], "json-stringify-tinderbox": [81.0, 83.0, 82.0, 87.0, 87.0, 88.0, 87.0, 85.0, 86.0, 87.0], "stanford-crypto-pbkdf2": [186.0, 193.0, 192.0, 189.0, 185.0, 185.0, 194.0, 189.0, 188.0, 174.0], "json-parse-financial": [78.0, 75.0, 75.0, 77.0, 81.0, 80.0, 80.0, 85.0, 78.0, 79.0], "stanford-crypto-sha256-iterative": [81.0, 84.0, 90.0, 89.0, 91.0, 88.0, 89.0, 88.0, 87.0, 88.0], "audio-fft": [81.0, 89.0, 100.0, 144.0, 80.0, 85.0, 85.0, 85.0, 117.0, 81.0], "imaging-darkroom": [157.0, 156.0, 158.0, 154.0, 150.0, 156.0, 156.0, 154.0, 150.0, 156.0], "stanford-crypto-ccm": [162.0, 169.0, 155.0, 151.0, 157.0, 164.0, 152.0, 155.0, 155.0, 155.0], "audio-oscillator": [103.0, 105.0, 154.0, 107.0, 111.0, 110.0, 143.0, 105.0, 105.0, 154.0], "stanford-crypto-aes": [103.0, 110.0, 109.0, 107.0, 110.0, 109.0, 106.0, 109.0, 108.0, 104.0], "imaging-desaturate": [120.0, 127.0, 117.0, 130.0, 119.0, 118.0, 117.0, 117.0, 123.0, 134.0]}, "summary": {"lowerIsBetter": true, "suite": 1851.8, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 94.7, "unit": "ms", "value": 94.7}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 187.5, "unit": "ms", "value": 187.5}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 179.8, "unit": "ms", "value": 179.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 157.5, "unit": "ms", "value": 157.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 154.7, "unit": "ms", "value": 154.7}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 78.8, "unit": "ms", "value": 78.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 119.7, "unit": "ms", "value": 119.7}, "ai-astar": {"lowerIsBetter": true, "filtered": 132.5, "unit": "ms", "value": 132.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 198.7, "unit": "ms", "value": 198.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 87.5, "unit": "ms", "value": 87.5}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 85.3, "unit": "ms", "value": 85.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 145.4, "unit": "ms", "value": 145.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 107.5, "unit": "ms", "value": 107.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 122.2, "unit": "ms", "value": 122.2}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0054.e"}, "testrun": {"date": 1447828586, "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": "20151117210240", "branch": "Fx-Team", "revision": "fb5b48c3abe6dc120cde93464372d2bf9095a7a2"}}, {"talos_counters": {}, "results": {"DeltaBlue": [230.62730627306274], "Encrypt": [372.0238095238095], "NavierStokes": [6718.120805369127], "Decrypt": [6829.931972789115], "Splay": [827.9569892473119], "Richards": [203.3760423022168], "RegExp": [34457.627118644064], "Earley": [1088.139281828074], "Boyer": [15164.179104477613], "RayTrace": [1305.4830287206266]}, "summary": {"lowerIsBetter": false, "suite": 16247.935964144674, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 286.6876479999999, "unit": "score", "value": 286.6876479999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 715.4945280000001, "unit": "score", "value": 715.4945280000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 220.89510489510505, "unit": "score", "value": 220.89510489510505}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.9727161354582, "unit": "score", "value": 38.9727161354582}, "Splay": {"lowerIsBetter": false, "filtered": 98.42419480519479, "unit": "score", "value": 98.42419480519479}, "RegExp": {"lowerIsBetter": false, "filtered": 26.437833251352668, "unit": "score", "value": 26.437833251352668}, "Richards": {"lowerIsBetter": false, "filtered": 173.579934, "unit": "score", "value": 173.579934}, "Earley": {"lowerIsBetter": false, "filtered": 612.4794970000002, "unit": "score", "value": 612.4794970000002}, "Boyer": {"lowerIsBetter": false, "filtered": 43.94982381889767, "unit": "score", "value": 43.94982381889767}, "RayTrace": {"lowerIsBetter": false, "filtered": 566.8315740000002, "unit": "score", "value": 566.8315740000002}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0054.e"}, "testrun": {"date": 1447828586, "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": "20151117210240", "branch": "Fx-Team", "revision": "fb5b48c3abe6dc120cde93464372d2bf9095a7a2"}}] 22:56:42 INFO - RETURN: dromaeo_css: 5736.59 22:56:42 INFO - RETURN: kraken: 1851.80 22:56:42 INFO - RETURN: v8_7: 16247.94 22:56:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "16247.94"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1851.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5736.59"}}} 22:56:42 INFO - Return code: 0 22:56:42 INFO - # TBPL SUCCESS # 22:56:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:56:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:56:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:56:42 INFO - 2015-11-17 22:56:42.280 screenresolution[1667:11983] starting screenresolution argv=screenresolution get 22:56:42 INFO - 2015-11-17 22:56:42.284 screenresolution[1667:11983] Display 0: 1600x1200x32@60 22:56:42 INFO - 2015-11-17 22:56:42.290 screenresolution[1668:11987] starting screenresolution argv=screenresolution list 22:56:42 INFO - Available Modes on Display 0 22:56:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:56:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:56:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:56:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:56:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:56:42 INFO - Intel HD Graphics 3000: 22:56:42 INFO - Chipset Model: Intel HD Graphics 3000 22:56:42 INFO - Type: GPU 22:56:42 INFO - Bus: Built-In 22:56:42 INFO - VRAM (Total): 512 MB 22:56:42 INFO - VRAM (Dynamic, Max): 10 22:56:42 INFO - Vendor: Intel (0x8086) 22:56:42 INFO - Device ID: 0x0116 22:56:42 INFO - Revision ID: 0x0009 22:56:42 INFO - Displays: 22:56:42 INFO - Display: 22:56:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:56:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:56:42 INFO - Display Serial Number: 1600x1200 60 22:56:42 INFO - Main Display: Yes 22:56:42 INFO - Mirror: Off 22:56:42 INFO - Online: Yes 22:56:42 INFO - Rotation: Supported 22:56:42 INFO - Return code: 0 22:56:42 INFO - Running post-action listener: _resource_record_post_action 22:56:42 INFO - Running post-run listener: _resource_record_post_run 22:56:43 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 39638016; Write bytes: 690888704; Read time: 5024; Write time: 53432 22:56:43 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 341504512; Write bytes: 336633856; Read time: 36291; Write time: 6375 22:56:43 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 37663744; Write bytes: 342966272; Read time: 4563; Write time: 45713 22:56:43 INFO - Running post-run listener: _upload_blobber_files 22:56:43 INFO - Blob upload gear active. 22:56:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:56:43 INFO - Copying logs to upload dir... 22:56:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1338.199362 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 18 secs) (at 2015-11-17 22:56:43.709246) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 22:56:43.712836) ========= 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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010713 build_url: 'https://queue.taskcluster.net/v1/task/MW9fKUwJS9Oegx48rP0m2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 22:56:43.740707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:56:43.741211) ========= 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.ThcP4JkU9D/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.RyR1rv4Mkq/Listeners TMPDIR=/var/folders/8h/l4613m_j02g_hw6ll7t0xgkr00000w/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.005816 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 22:56:43.791904) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 22:56:43.792270) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 22:56:43.792754) ========= ========= Total master_lag: 0.27 =========