builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0100 starttime: 1447414553.89 results: success (0) buildid: 20151113013632 builduid: 432ca81a736f4218b7e21ae7745171e4 revision: d6d640c4b8c2097f3a780f6420c197dc698a8183 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:53.888009) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:53.888503) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:53.888873) ========= 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.wFqUfkokw7/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.hOqNThr9ho/Listeners TMPDIR=/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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.006665 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:53.914635) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:53.914996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:53.936562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:53.936962) ========= 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.wFqUfkokw7/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.hOqNThr9ho/Listeners TMPDIR=/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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.005777 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:53.992461) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:53.992827) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:53.993281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:53.993671) ========= 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.wFqUfkokw7/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.hOqNThr9ho/Listeners TMPDIR=/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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-13 03:35:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.13G=0s 2015-11-13 03:35:54 (1.13 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187628 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:54.201063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:54.201715) ========= 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.wFqUfkokw7/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.hOqNThr9ho/Listeners TMPDIR=/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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.021624 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:54.252392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:54.252816) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d6d640c4b8c2097f3a780f6420c197dc698a8183 --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 d6d640c4b8c2097f3a780f6420c197dc698a8183 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wFqUfkokw7/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.hOqNThr9ho/Listeners TMPDIR=/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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-13 03:35:54,328 truncating revision to first 12 chars 2015-11-13 03:35:54,329 Setting DEBUG logging. 2015-11-13 03:35:54,329 attempt 1/10 2015-11-13 03:35:54,329 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d6d640c4b8c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 03:35:54,595 unpacking tar archive at: fx-team-d6d640c4b8c2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.539145 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:54.811122) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:54.811548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:54.826979) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:54.827330) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 03:35:54.827837) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2015-11-13 03:35:54.828254) ========= /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.wFqUfkokw7/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.hOqNThr9ho/Listeners TMPDIR=/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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 03:35:55 INFO - MultiFileLogger online at 20151113 03:35:55 in /builds/slave/test 03:35:55 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 03:35:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:35:55 INFO - {'append_to_log': False, 03:35:55 INFO - 'base_work_dir': '/builds/slave/test', 03:35:55 INFO - 'blob_upload_branch': 'Fx-Team', 03:35:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:35:55 INFO - 'branch': 'Fx-Team', 03:35:55 INFO - 'buildbot_json_path': 'buildprops.json', 03:35:55 INFO - 'config_files': ('talos/mac_config.py',), 03:35:55 INFO - 'default_actions': ('clobber', 03:35:55 INFO - 'read-buildbot-config', 03:35:55 INFO - 'download-and-extract', 03:35:55 INFO - 'populate-webroot', 03:35:55 INFO - 'create-virtualenv', 03:35:55 INFO - 'install', 03:35:55 INFO - 'run-tests'), 03:35:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:35:55 INFO - 'download_minidump_stackwalk': True, 03:35:55 INFO - 'download_symbols': 'ondemand', 03:35:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:35:55 INFO - 'tooltool.py': '/tools/tooltool.py', 03:35:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:35:55 INFO - '/tools/misc-python/virtualenv.py')}, 03:35:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:35:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:35:55 INFO - 'installer_path': 'installer.exe', 03:35:55 INFO - 'log_level': 'info', 03:35:55 INFO - 'log_name': 'talos', 03:35:55 INFO - 'log_to_console': True, 03:35:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:35:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:35:55 INFO - 'opt_config_files': (), 03:35:55 INFO - 'pip_index': False, 03:35:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:35:55 INFO - 'cmd': ('bash', 03:35:55 INFO - '-c', 03:35:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:35:55 INFO - 'enabled': True, 03:35:55 INFO - 'halt_on_failure': False, 03:35:55 INFO - 'name': 'check_screen_resolution'},), 03:35:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:35:55 INFO - 'cmd': ('bash', 03:35:55 INFO - '-c', 03:35:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:35:55 INFO - 'enabled': True, 03:35:55 INFO - 'halt_on_failure': False, 03:35:55 INFO - 'name': 'check_screen_resolution'},), 03:35:55 INFO - 'run_cmd_checks_enabled': True, 03:35:55 INFO - 'sps_profile': False, 03:35:55 INFO - 'sps_profile_interval': 0, 03:35:55 INFO - 'suite': 'dromaeojs-e10s', 03:35:55 INFO - 'system_bits': '64', 03:35:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:35:55 INFO - 'title': 't-yosemite-r5-0100', 03:35:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:35:55 INFO - 'use_talos_json': True, 03:35:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:35:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:35:55 INFO - 'work_dir': 'build'} 03:35:55 INFO - ##### 03:35:55 INFO - ##### Running clobber step. 03:35:55 INFO - ##### 03:35:55 INFO - Running pre-action listener: _resource_record_pre_action 03:35:55 INFO - Running main action method: clobber 03:35:55 INFO - rmtree: /builds/slave/test/build 03:35:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:35:58 INFO - Running post-action listener: _resource_record_post_action 03:35:58 INFO - ##### 03:35:58 INFO - ##### Running read-buildbot-config step. 03:35:58 INFO - ##### 03:35:58 INFO - Running pre-action listener: _resource_record_pre_action 03:35:58 INFO - Running main action method: read_buildbot_config 03:35:58 INFO - Using buildbot properties: 03:35:58 INFO - { 03:35:58 INFO - "properties": { 03:35:58 INFO - "buildnumber": 34, 03:35:58 INFO - "product": "firefox", 03:35:58 INFO - "script_repo_revision": "production", 03:35:58 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 03:35:58 INFO - "repository": "", 03:35:58 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 03:35:58 INFO - "buildid": "20151113013632", 03:35:58 INFO - "slavename": "t-yosemite-r5-0100", 03:35:58 INFO - "pgo_build": "False", 03:35:58 INFO - "basedir": "/builds/slave/test", 03:35:58 INFO - "project": "", 03:35:58 INFO - "platform": "yosemite", 03:35:58 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:35:58 INFO - "slavebuilddir": "test", 03:35:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:35:58 INFO - "branch": "fx-team", 03:35:58 INFO - "repo_path": "integration/fx-team", 03:35:58 INFO - "stage_platform": "macosx64", 03:35:58 INFO - "builduid": "432ca81a736f4218b7e21ae7745171e4", 03:35:58 INFO - "revision": "d6d640c4b8c2097f3a780f6420c197dc698a8183" 03:35:58 INFO - }, 03:35:58 INFO - "sourcestamp": { 03:35:58 INFO - "repository": "", 03:35:58 INFO - "hasPatch": false, 03:35:58 INFO - "project": "", 03:35:58 INFO - "branch": "fx-team-macosx64-talos", 03:35:58 INFO - "changes": [ 03:35:58 INFO - { 03:35:58 INFO - "category": null, 03:35:58 INFO - "files": [ 03:35:58 INFO - { 03:35:58 INFO - "url": null, 03:35:58 INFO - "name": "https://queue.taskcluster.net/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 03:35:58 INFO - } 03:35:58 INFO - ], 03:35:58 INFO - "repository": "", 03:35:58 INFO - "rev": "d6d640c4b8c2097f3a780f6420c197dc698a8183", 03:35:58 INFO - "who": "ejpbruel@mozilla.com", 03:35:58 INFO - "when": 1447412146, 03:35:58 INFO - "number": 6657510, 03:35:58 INFO - "comments": "Bug 1221892 - Extend the debugger protocol to get the matching service worker registration;r=janx", 03:35:58 INFO - "project": "", 03:35:58 INFO - "at": "Fri 13 Nov 2015 02:55:46", 03:35:58 INFO - "branch": "fx-team-macosx64-talos", 03:35:58 INFO - "revlink": "", 03:35:58 INFO - "properties": [ 03:35:58 INFO - [ 03:35:58 INFO - "buildid", 03:35:58 INFO - "20151113013632", 03:35:58 INFO - "Change" 03:35:58 INFO - ], 03:35:58 INFO - [ 03:35:58 INFO - "builduid", 03:35:58 INFO - "432ca81a736f4218b7e21ae7745171e4", 03:35:58 INFO - "Change" 03:35:58 INFO - ], 03:35:58 INFO - [ 03:35:58 INFO - "pgo_build", 03:35:58 INFO - "False", 03:35:58 INFO - "Change" 03:35:58 INFO - ] 03:35:58 INFO - ], 03:35:58 INFO - "revision": "d6d640c4b8c2097f3a780f6420c197dc698a8183" 03:35:58 INFO - } 03:35:58 INFO - ], 03:35:58 INFO - "revision": "d6d640c4b8c2097f3a780f6420c197dc698a8183" 03:35:58 INFO - } 03:35:58 INFO - } 03:35:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 03:35:58 INFO - Running post-action listener: _resource_record_post_action 03:35:58 INFO - ##### 03:35:58 INFO - ##### Running download-and-extract step. 03:35:58 INFO - ##### 03:35:58 INFO - Running pre-action listener: _resource_record_pre_action 03:35:58 INFO - Running main action method: download_and_extract 03:35:58 INFO - mkdir: /builds/slave/test/build/tests 03:35:58 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')]} 03:35:58 INFO - https://queue.taskcluster.net/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:35:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/test_packages.json 03:35:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/test_packages.json 03:35:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:35:58 INFO - Downloaded 1149 bytes. 03:35:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:35:58 INFO - Using the following test package requirements: 03:35:58 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:35:58 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:35:58 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 03:35:58 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:35:58 INFO - u'jsshell-mac.zip'], 03:35:58 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:35:58 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 03:35:58 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:35:58 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:35:58 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 03:35:58 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:35:58 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 03:35:58 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:35:58 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 03:35:58 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 03:35:58 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 03:35:58 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 03:35:58 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:35:58 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')]} 03:35:58 INFO - https://queue.taskcluster.net/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:35:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:35:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:35:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/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 03:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/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 03:36:00 INFO - Downloaded 17460334 bytes. 03:36:00 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 03:36:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:36:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:36:05 INFO - Return code: 0 03:36:05 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 03:36:05 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')]} 03:36:05 INFO - https://queue.taskcluster.net/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:36:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:36:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:36:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/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 03:36:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/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 03:36:07 INFO - Downloaded 17460334 bytes. 03:36:07 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 03:36:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 03:36:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 03:36:14 INFO - Return code: 0 03:36:14 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')]} 03:36:14 INFO - https://queue.taskcluster.net/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:36:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:36:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:36:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/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 03:36:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/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 03:36:15 INFO - Downloaded 11131693 bytes. 03:36:15 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 03:36:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 03:36:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 03:36:16 INFO - Return code: 0 03:36: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')]} 03:36:16 INFO - https://queue.taskcluster.net/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:36:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:36:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:36:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 03:36:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/y4EsqqoGQ1GdPv8ugNBelw/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 03:36:19 INFO - Downloaded 108701140 bytes. 03:36:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:36:19 INFO - mkdir: /builds/slave/test/properties 03:36:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:19 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:19 INFO - Contents: 03:36:19 INFO - build_url:https://queue.taskcluster.net/v1/task/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 03:36:19 INFO - Running post-action listener: _resource_record_post_action 03:36:19 INFO - Running post-action listener: set_extra_try_arguments 03:36:19 INFO - ##### 03:36:19 INFO - ##### Running populate-webroot step. 03:36:19 INFO - ##### 03:36:19 INFO - Running pre-action listener: _resource_record_pre_action 03:36:19 INFO - Running main action method: populate_webroot 03:36:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:36:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:36:19 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:36:19 INFO - '../fennec_ids.txt'], 03:36:19 INFO - 'tests': ['tcheck2']}, 03:36:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:36:19 INFO - '--tppagecycles', 03:36:19 INFO - '7'], 03:36:19 INFO - 'tests': ['tsvgm']}}, 03:36:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:36:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:36:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:36:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:36:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:36:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:36:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:19 INFO - 'talos_options': ['--e10s'], 03:36:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:19 INFO - 'tests': ['damp', 'tps']}, 03:36:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:19 INFO - 'talos_options': ['--e10s'], 03:36:19 INFO - 'tests': ['damp', 'tps']}, 03:36:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:36:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:19 INFO - 'other': {'tests': ['a11yr', 03:36:19 INFO - 'ts_paint', 03:36:19 INFO - 'tpaint', 03:36:19 INFO - 'sessionrestore', 03:36:19 INFO - 'sessionrestore_no_auto_restore']}, 03:36:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:36:19 INFO - 'tests': ['a11yr', 03:36:19 INFO - 'ts_paint', 03:36:19 INFO - 'tpaint', 03:36:19 INFO - 'sessionrestore', 03:36:19 INFO - 'sessionrestore_no_auto_restore']}, 03:36:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:36:19 INFO - 'tests': ['a11yr', 03:36:19 INFO - 'ts_paint', 03:36:19 INFO - 'tpaint', 03:36:19 INFO - 'sessionrestore', 03:36:19 INFO - 'sessionrestore_no_auto_restore']}, 03:36:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:36:19 INFO - 'tests': ['a11yr', 03:36:19 INFO - 'ts_paint', 03:36:19 INFO - 'tpaint', 03:36:19 INFO - 'sessionrestore', 03:36:19 INFO - 'sessionrestore_no_auto_restore']}, 03:36:19 INFO - 'other_l64': {'tests': ['a11yr', 03:36:19 INFO - 'ts_paint', 03:36:19 INFO - 'tpaint', 03:36:19 INFO - 'sessionrestore', 03:36:19 INFO - 'sessionrestore_no_auto_restore']}, 03:36:19 INFO - 'other_nol64': {'tests': ['a11yr', 03:36:19 INFO - 'ts_paint', 03:36:19 INFO - 'tpaint', 03:36:19 INFO - 'sessionrestore', 03:36:19 INFO - 'sessionrestore_no_auto_restore']}, 03:36:19 INFO - 'svgr': {'tests': ['tsvgx', 03:36:19 INFO - 'tsvgr_opacity', 03:36:19 INFO - 'tart', 03:36:19 INFO - 'tscrollx', 03:36:19 INFO - 'cart']}, 03:36:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:36:19 INFO - 'tests': ['tsvgx', 03:36:19 INFO - 'tsvgr_opacity', 03:36:19 INFO - 'tart', 03:36:19 INFO - 'tscrollx', 03:36:19 INFO - 'cart']}, 03:36:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:19 INFO - 'tests': ['tp5o']}, 03:36:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:19 INFO - 'talos_options': ['--e10s'], 03:36:19 INFO - 'tests': ['tp5o']}, 03:36:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:19 INFO - 'talos_options': ['--xperf_path', 03:36:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:19 INFO - 'tests': ['tp5n']}, 03:36:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:19 INFO - 'talos_options': ['--e10s', 03:36:19 INFO - '--xperf_path', 03:36:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:19 INFO - 'tests': ['tp5n']}}, 03:36:19 INFO - 'talos.zip': {'path': '', 03:36:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:36:19 INFO - Running post-action listener: _resource_record_post_action 03:36:19 INFO - ##### 03:36:19 INFO - ##### Running create-virtualenv step. 03:36:19 INFO - ##### 03:36:19 INFO - Running pre-action listener: _resource_record_pre_action 03:36:19 INFO - Running main action method: create_virtualenv 03:36:19 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:19 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 03:36:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:36:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:19 INFO - Using real prefix '/tools/python27' 03:36:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:20 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:24 INFO - Installing pip.................done. 03:36:24 INFO - Return code: 0 03:36:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9b614d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10081f9f0>, '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 0x10057fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008138c8>, '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.wFqUfkokw7/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.hOqNThr9ho/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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 03:36:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:36:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:36:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFqUfkokw7/Render', 03:36:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:24 INFO - 'HOME': '/Users/cltbld', 03:36:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:24 INFO - 'LOGNAME': 'cltbld', 03:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:24 INFO - 'MOZ_NO_REMOTE': '1', 03:36:24 INFO - 'NO_EM_RESTART': '1', 03:36:24 INFO - 'PAGER': '/bin/cat', 03:36:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:24 INFO - 'PWD': '/builds/slave/test', 03:36:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:24 INFO - 'SHELL': '/bin/bash', 03:36:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hOqNThr9ho/Listeners', 03:36:24 INFO - 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/', 03:36:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:24 INFO - 'USER': 'cltbld', 03:36:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:24 INFO - 'XPC_FLAGS': '0x0', 03:36:24 INFO - 'XPC_SERVICE_NAME': '0', 03:36:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:25 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 03:36:25 INFO - Cleaning up... 03:36:25 INFO - Return code: 0 03:36:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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', '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 0x1008fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9b614d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10081f9f0>, '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 0x10057fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008138c8>, '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.wFqUfkokw7/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.hOqNThr9ho/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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 03:36: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:36: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 psutil>=0.7.1 03:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFqUfkokw7/Render', 03:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:25 INFO - 'HOME': '/Users/cltbld', 03:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:25 INFO - 'LOGNAME': 'cltbld', 03:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:25 INFO - 'MOZ_NO_REMOTE': '1', 03:36:25 INFO - 'NO_EM_RESTART': '1', 03:36:25 INFO - 'PAGER': '/bin/cat', 03:36:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:25 INFO - 'PWD': '/builds/slave/test', 03:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:25 INFO - 'SHELL': '/bin/bash', 03:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hOqNThr9ho/Listeners', 03:36:25 INFO - 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/', 03:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:25 INFO - 'USER': 'cltbld', 03:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:25 INFO - 'XPC_FLAGS': '0x0', 03:36:25 INFO - 'XPC_SERVICE_NAME': '0', 03:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:25 INFO - Downloading/unpacking psutil>=0.7.1 03:36:25 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 03:36:25 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 03:36:25 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 03:36:25 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 03:36:25 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 03:36:25 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 03:36:28 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:36:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:28 INFO - Installing collected packages: psutil 03:36:28 INFO - Running setup.py install for psutil 03:36:28 INFO - building 'psutil._psutil_osx' extension 03:36:28 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 03:36:28 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 03:36:28 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 03:36:29 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 03:36:29 INFO - building 'psutil._psutil_posix' extension 03:36:29 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 03:36:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:36:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:36:29 INFO - ^ 03:36:29 INFO - 1 warning generated. 03:36:29 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 03:36:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:29 INFO - Successfully installed psutil 03:36:29 INFO - Cleaning up... 03:36:29 INFO - Return code: 0 03:36:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36: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')]} 03:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1008fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9b614d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10081f9f0>, '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 0x10057fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008138c8>, '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.wFqUfkokw7/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.hOqNThr9ho/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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 03:36:29 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 03:36:29 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 03:36:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFqUfkokw7/Render', 03:36:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:29 INFO - 'HOME': '/Users/cltbld', 03:36:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:29 INFO - 'LOGNAME': 'cltbld', 03:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:29 INFO - 'MOZ_NO_REMOTE': '1', 03:36:29 INFO - 'NO_EM_RESTART': '1', 03:36:29 INFO - 'PAGER': '/bin/cat', 03:36:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:29 INFO - 'PWD': '/builds/slave/test', 03:36:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:29 INFO - 'SHELL': '/bin/bash', 03:36:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hOqNThr9ho/Listeners', 03:36:29 INFO - 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/', 03:36:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:29 INFO - 'USER': 'cltbld', 03:36:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:29 INFO - 'XPC_FLAGS': '0x0', 03:36:29 INFO - 'XPC_SERVICE_NAME': '0', 03:36:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:36: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 03:36: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 03:36: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 03:36: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 03:36: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 03:36: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 03:36:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:36:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:36:32 INFO - Installing collected packages: mozsystemmonitor 03:36:32 INFO - Running setup.py install for mozsystemmonitor 03:36:32 INFO - Successfully installed mozsystemmonitor 03:36:32 INFO - Cleaning up... 03:36:32 INFO - Return code: 0 03:36:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:32 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 0x1008fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9b614d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10081f9f0>, '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 0x10057fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008138c8>, '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.wFqUfkokw7/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.hOqNThr9ho/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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 03:36:32 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 03:36:32 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 03:36:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFqUfkokw7/Render', 03:36:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:32 INFO - 'HOME': '/Users/cltbld', 03:36:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:32 INFO - 'LOGNAME': 'cltbld', 03:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:32 INFO - 'MOZ_NO_REMOTE': '1', 03:36:32 INFO - 'NO_EM_RESTART': '1', 03:36:32 INFO - 'PAGER': '/bin/cat', 03:36:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:32 INFO - 'PWD': '/builds/slave/test', 03:36:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:32 INFO - 'SHELL': '/bin/bash', 03:36:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hOqNThr9ho/Listeners', 03:36:32 INFO - 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/', 03:36:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:32 INFO - 'USER': 'cltbld', 03:36:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:32 INFO - 'XPC_FLAGS': '0x0', 03:36:32 INFO - 'XPC_SERVICE_NAME': '0', 03:36:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:33 INFO - Downloading/unpacking blobuploader==1.2.4 03:36:33 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 03:36:33 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 03:36:33 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 03:36:33 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 03:36:33 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 03:36:33 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 03:36:35 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:36 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 03:36:36 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 03:36:36 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 03:36:36 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 03:36:36 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 03:36:36 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 03:36:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:36 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 03:36:36 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 03:36:36 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 03:36:36 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 03:36:36 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 03:36:36 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 03:36:37 INFO - Downloading docopt-0.6.1.tar.gz 03:36:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:37 INFO - Running setup.py install for blobuploader 03:36:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:37 INFO - Running setup.py install for requests 03:36:38 INFO - Running setup.py install for docopt 03:36:38 INFO - Successfully installed blobuploader requests docopt 03:36:38 INFO - Cleaning up... 03:36:38 INFO - Return code: 0 03:36:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:38 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')]} 03:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:38 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')]} 03:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:38 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 0x1008fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9b614d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10081f9f0>, '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 0x10057fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008138c8>, '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.wFqUfkokw7/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.hOqNThr9ho/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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 03:36:38 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 03:36:38 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 03:36:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFqUfkokw7/Render', 03:36:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:38 INFO - 'HOME': '/Users/cltbld', 03:36:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:38 INFO - 'LOGNAME': 'cltbld', 03:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:38 INFO - 'MOZ_NO_REMOTE': '1', 03:36:38 INFO - 'NO_EM_RESTART': '1', 03:36:38 INFO - 'PAGER': '/bin/cat', 03:36:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:38 INFO - 'PWD': '/builds/slave/test', 03:36:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:38 INFO - 'SHELL': '/bin/bash', 03:36:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hOqNThr9ho/Listeners', 03:36:38 INFO - 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/', 03:36:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:38 INFO - 'USER': 'cltbld', 03:36:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:38 INFO - 'XPC_FLAGS': '0x0', 03:36:38 INFO - 'XPC_SERVICE_NAME': '0', 03:36:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:38 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-Cdg4D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:38 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-J71bHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:39 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-kC_bws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:39 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-SQEkwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:39 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-50OQml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:39 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-HUEOSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:39 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-ix6Aiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:39 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-QEUGER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:39 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-NVItKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:40 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-8pUOpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:40 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-SBh_o9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:40 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-8vAPqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:40 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-fpBXOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:40 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-tilGzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:40 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-HlA157-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:40 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-QuZbbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:41 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-vrAAdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:41 INFO - Running setup.py install for manifestparser 03:36:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:41 INFO - Running setup.py install for mozcrash 03:36:41 INFO - Running setup.py install for mozdebug 03:36:41 INFO - Running setup.py install for mozdevice 03:36:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:36:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:41 INFO - Running setup.py install for mozfile 03:36:42 INFO - Running setup.py install for mozhttpd 03:36:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:42 INFO - Running setup.py install for mozinfo 03:36:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:42 INFO - Running setup.py install for mozInstall 03:36:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:42 INFO - Running setup.py install for mozleak 03:36:42 INFO - Running setup.py install for mozlog 03:36:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:43 INFO - Running setup.py install for moznetwork 03:36:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:43 INFO - Running setup.py install for mozprocess 03:36:43 INFO - Running setup.py install for mozprofile 03:36:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:43 INFO - Running setup.py install for mozrunner 03:36:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:43 INFO - Running setup.py install for mozscreenshot 03:36:44 INFO - Running setup.py install for moztest 03:36:44 INFO - Running setup.py install for mozversion 03:36:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:44 INFO - Cleaning up... 03:36:44 INFO - Return code: 0 03:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:44 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')]} 03:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:44 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')]} 03:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:44 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 0x1008fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9b614d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10081f9f0>, '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 0x10057fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008138c8>, '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.wFqUfkokw7/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.hOqNThr9ho/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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 03:36:44 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 03:36:44 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 03:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFqUfkokw7/Render', 03:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:44 INFO - 'HOME': '/Users/cltbld', 03:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:44 INFO - 'LOGNAME': 'cltbld', 03:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:44 INFO - 'MOZ_NO_REMOTE': '1', 03:36:44 INFO - 'NO_EM_RESTART': '1', 03:36:44 INFO - 'PAGER': '/bin/cat', 03:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:44 INFO - 'PWD': '/builds/slave/test', 03:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:44 INFO - 'SHELL': '/bin/bash', 03:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hOqNThr9ho/Listeners', 03:36:44 INFO - 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/', 03:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:44 INFO - 'USER': 'cltbld', 03:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:44 INFO - 'XPC_FLAGS': '0x0', 03:36:44 INFO - 'XPC_SERVICE_NAME': '0', 03:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:44 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-uphx0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:45 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)) 03:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:45 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-S6NM7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:45 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)) 03:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:45 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-2QS8Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:45 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)) 03:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:45 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-gkA5m_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:45 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)) 03:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:45 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-QiJmk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:45 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)) 03:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:45 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-DjAdMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:45 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)) 03:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:45 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-DRiR8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:45 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)) 03:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:45 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-rwB78D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:46 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-IBfw_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:46 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-7OTlIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:46 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-ZXk9BU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:46 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-KoUXoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:46 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-XOoWDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:46 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-e9fOnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:46 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)) 03:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:46 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-CNOgVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:47 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)) 03:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:47 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-o_urHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:47 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)) 03:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:47 INFO - Running setup.py (path:/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/pip-aUZDTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:47 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)) 03:36:47 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)) 03:36:47 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)) 03:36:47 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)) 03:36:47 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)) 03:36:47 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)) 03:36:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:47 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 03:36:47 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 03:36:47 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 03:36:47 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 03:36:47 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 03:36:47 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 03:36:50 INFO - Downloading blessings-1.5.1.tar.gz 03:36:50 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 03:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:36:50 INFO - Installing collected packages: blessings 03:36:50 INFO - Running setup.py install for blessings 03:36:50 INFO - Successfully installed blessings 03:36:50 INFO - Cleaning up... 03:36:50 INFO - Return code: 0 03:36:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:36:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:50 INFO - Reading from file tmpfile_stdout 03:36:50 INFO - Current package versions: 03:36:50 INFO - blessings == 1.5.1 03:36:50 INFO - blobuploader == 1.2.4 03:36:50 INFO - docopt == 0.6.1 03:36:50 INFO - manifestparser == 1.1 03:36:50 INFO - mozInstall == 1.12 03:36:50 INFO - mozcrash == 0.16 03:36:50 INFO - mozdebug == 0.1 03:36:50 INFO - mozdevice == 0.47 03:36:50 INFO - mozfile == 1.2 03:36:50 INFO - mozhttpd == 0.7 03:36:50 INFO - mozinfo == 0.9 03:36:50 INFO - mozleak == 0.1 03:36:50 INFO - mozlog == 3.0 03:36:50 INFO - moznetwork == 0.27 03:36:50 INFO - mozprocess == 0.22 03:36:50 INFO - mozprofile == 0.27 03:36:50 INFO - mozrunner == 6.11 03:36:50 INFO - mozscreenshot == 0.1 03:36:50 INFO - mozsystemmonitor == 0.0 03:36:50 INFO - moztest == 0.7 03:36:50 INFO - mozversion == 1.4 03:36:50 INFO - psutil == 3.1.1 03:36:50 INFO - requests == 1.2.3 03:36:50 INFO - wsgiref == 0.1.2 03:36:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:36:50 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 0x1008fc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008d9228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9d9b614d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10081f9f0>, '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 0x10057fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008138c8>, '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.wFqUfkokw7/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.hOqNThr9ho/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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 03:36:50 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 03:36:50 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 03:36:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFqUfkokw7/Render', 03:36:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:36:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:36:50 INFO - 'HOME': '/Users/cltbld', 03:36:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:36:50 INFO - 'LOGNAME': 'cltbld', 03:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:50 INFO - 'MOZ_NO_REMOTE': '1', 03:36:50 INFO - 'NO_EM_RESTART': '1', 03:36:50 INFO - 'PAGER': '/bin/cat', 03:36:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:50 INFO - 'PWD': '/builds/slave/test', 03:36:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:36:50 INFO - 'SHELL': '/bin/bash', 03:36:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hOqNThr9ho/Listeners', 03:36:50 INFO - 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/', 03:36:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:36:50 INFO - 'USER': 'cltbld', 03:36:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:36:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:50 INFO - 'XPC_FLAGS': '0x0', 03:36:50 INFO - 'XPC_SERVICE_NAME': '0', 03:36:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:51 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)) 03:36:51 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)) 03:36:51 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)) 03:36:51 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)) 03:36:51 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)) 03:36:51 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)) 03:36:51 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)) 03:36:51 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)) 03:36:51 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)) 03:36:51 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)) 03:36:51 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)) 03:36:51 INFO - Cleaning up... 03:36:51 INFO - Return code: 0 03:36:51 INFO - Running post-action listener: _resource_record_post_action 03:36:51 INFO - Running post-action listener: _start_resource_monitoring 03:36:51 INFO - Starting resource monitoring. 03:36:51 INFO - ##### 03:36:51 INFO - ##### Running install step. 03:36:51 INFO - ##### 03:36:51 INFO - Running pre-action listener: _resource_record_pre_action 03:36:51 INFO - Running main action method: install 03:36:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:51 INFO - Reading from file tmpfile_stdout 03:36:51 INFO - Detecting whether we're running mozinstall >=1.0... 03:36:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:36:51 INFO - Reading from file tmpfile_stdout 03:36:51 INFO - Output received: 03:36:51 INFO - Usage: mozinstall [options] installer 03:36:51 INFO - Options: 03:36:51 INFO - -h, --help show this help message and exit 03:36:51 INFO - -d DEST, --destination=DEST 03:36:51 INFO - Directory to install application into. [default: 03:36:51 INFO - "/builds/slave/test"] 03:36:51 INFO - --app=APP Application being installed. [default: firefox] 03:36:51 INFO - mkdir: /builds/slave/test/build/application 03:36:51 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'] 03:36:51 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 03:37:34 INFO - Reading from file tmpfile_stdout 03:37:34 INFO - Output received: 03:37:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:37:34 INFO - Running post-action listener: _resource_record_post_action 03:37:34 INFO - ##### 03:37:34 INFO - ##### Running run-tests step. 03:37:34 INFO - ##### 03:37:34 INFO - Running pre-action listener: _resource_record_pre_action 03:37:34 INFO - Running main action method: run_tests 03:37:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:37:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:37:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:37:34 INFO - 2015-11-13 03:37:34.335 screenresolution[1972:16573] starting screenresolution argv=screenresolution get 03:37:34 INFO - 2015-11-13 03:37:34.339 screenresolution[1972:16573] Display 0: 1600x1200x32@60 03:37:34 INFO - 2015-11-13 03:37:34.346 screenresolution[1973:16575] starting screenresolution argv=screenresolution list 03:37:34 INFO - Available Modes on Display 0 03:37:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:37:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:37:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:37:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:37:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:37:34 INFO - Intel HD Graphics 3000: 03:37:34 INFO - Chipset Model: Intel HD Graphics 3000 03:37:34 INFO - Type: GPU 03:37:34 INFO - Bus: Built-In 03:37:34 INFO - VRAM (Total): 512 MB 03:37:34 INFO - VRAM (Dynamic, Max): 10 03:37:34 INFO - Vendor: Intel (0x8086) 03:37:34 INFO - Device ID: 0x0116 03:37:34 INFO - Revision ID: 0x0009 03:37:34 INFO - Displays: 03:37:34 INFO - Display: 03:37:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:37:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:37:34 INFO - Display Serial Number: 1600x1200 60 03:37:34 INFO - Main Display: Yes 03:37:34 INFO - Mirror: Off 03:37:34 INFO - Online: Yes 03:37:34 INFO - Rotation: Supported 03:37:34 INFO - Return code: 0 03:37:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:34 INFO - Python 2.7.3 03:37:34 INFO - Return code: 0 03:37:34 INFO - grabbing minidump binary from tooltool 03:37:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:37:34 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 0x10081f9f0>, '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 0x10057fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008138c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37:34 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 03:37:34 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 03:37:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:34 INFO - Return code: 0 03:37:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:37:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:37:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:34 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/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0100', '--webServer', 'localhost'] in /builds/slave/test/build 03:37:34 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/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0100 --webServer localhost 03:37:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wFqUfkokw7/Render', 03:37:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:34 INFO - 'HOME': '/Users/cltbld', 03:37:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:34 INFO - 'LOGNAME': 'cltbld', 03:37:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:37:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:34 INFO - 'MOZ_NO_REMOTE': '1', 03:37:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:34 INFO - 'NO_EM_RESTART': '1', 03:37:34 INFO - 'PAGER': '/bin/cat', 03:37:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:34 INFO - 'PWD': '/builds/slave/test', 03:37:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:34 INFO - 'SHELL': '/bin/bash', 03:37:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hOqNThr9ho/Listeners', 03:37:34 INFO - 'TMPDIR': '/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/', 03:37:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:34 INFO - 'USER': 'cltbld', 03:37:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:34 INFO - 'XPC_FLAGS': '0x0', 03:37:34 INFO - 'XPC_SERVICE_NAME': '0', 03:37:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 03:37:34 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/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0100', '--webServer', 'localhost'] with output_timeout 3600 03:37:35 INFO - mozversion INFO | application_buildid: 20151113013632 03:37:35 INFO - mozversion INFO | application_changeset: d6d640c4b8c2097f3a780f6420c197dc698a8183 03:37:35 INFO - mozversion INFO | application_display_name: Nightly 03:37:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:35 INFO - mozversion INFO | application_name: Firefox 03:37:35 INFO - mozversion INFO | application_remotingname: firefox 03:37:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:37:35 INFO - mozversion INFO | application_vendor: Mozilla 03:37:35 INFO - mozversion INFO | application_version: 45.0a1 03:37:35 INFO - mozversion INFO | platform_buildid: 20151113013632 03:37:35 INFO - mozversion INFO | platform_changeset: d6d640c4b8c2097f3a780f6420c197dc698a8183 03:37:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:37:35 INFO - mozversion INFO | platform_version: 45.0a1 03:37:35 INFO - 2015-11-13 03:37:35,008 DEBUG : using testdate: 1447414655 03:37:35 INFO - 2015-11-13 03:37:35,008 DEBUG : actual date: 1447414655 03:37:35 INFO - 2015-11-13 03:37:35,019 INFO : starting webserver on 'localhost:51222' 03:37:35 INFO - 2015-11-13 03:37:35,020 INFO : Starting test suite t-yosemite-r5-0100.e 03:37:35 INFO - 2015-11-13 03:37:35,020 INFO : Starting test dromaeo_css 03:37:35 INFO - 2015-11-13 03:37:35,020 DEBUG : operating with platform_type : mac_ 03:37:35 INFO - 2015-11-13 03:37:35,021 INFO : Initialising browser for dromaeo_css test... 03:37:35 INFO - 2015-11-13 03:37:35,060 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/tmpAI5XAV/profile http://localhost:51222/getInfo.html 03:37:38 INFO - 2015-11-13 03:37:38,963 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:37:38 INFO - 2015-11-13 03:37:38,963 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:37:38 INFO - 2015-11-13 03:37:38,963 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:37:38 INFO - 2015-11-13 03:37:38,964 DEBUG : BROWSER_OUTPUT: __metrics 03:37:39 INFO - 2015-11-13 03:37:39,746 INFO : Browser initialized. 03:37:39 INFO - 2015-11-13 03:37:39,746 INFO : Running cycle 1/1 for dromaeo_css test... 03:37:39 INFO - 2015-11-13 03:37:39,746 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/tmpAI5XAV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:37:51 INFO - 2015-11-13 03:37:51,968 DEBUG : BROWSER_OUTPUT: RSS: Main: 240115712 03:37:51 INFO - 2015-11-13 03:37:51,968 DEBUG : BROWSER_OUTPUT: 03:38:41 INFO - 2015-11-13 03:38:41,824 DEBUG : BROWSER_OUTPUT: 1447414721821 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] 03:40:52 INFO - 2015-11-13 03:40:52,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51222/tests/dromaeo/cssquery-ext.html) 03:40:53 INFO - 2015-11-13 03:40:53,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 266309632 03:40:53 INFO - 2015-11-13 03:40:53,796 DEBUG : BROWSER_OUTPUT: 03:43:55 INFO - 2015-11-13 03:43:55,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-ext.html (next: http://localhost:51222/tests/dromaeo/cssquery-jquery.html) 03:43:56 INFO - 2015-11-13 03:43:56,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 272158720 03:43:56 INFO - 2015-11-13 03:43:56,382 DEBUG : BROWSER_OUTPUT: 03:46:58 INFO - 2015-11-13 03:46:58,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51222/tests/dromaeo/cssquery-mootools.html) 03:46:58 INFO - 2015-11-13 03:46:58,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 274735104 03:46:58 INFO - 2015-11-13 03:46:58,731 DEBUG : BROWSER_OUTPUT: 03:50:00 INFO - 2015-11-13 03:50:00,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51222/tests/dromaeo/cssquery-prototype.html) 03:50:01 INFO - 2015-11-13 03:50:01,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 278630400 03:50:01 INFO - 2015-11-13 03:50:01,111 DEBUG : BROWSER_OUTPUT: 03:53:03 INFO - 2015-11-13 03:53:03,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51222/tests/dromaeo/cssquery-yui.html) 03:53:04 INFO - 2015-11-13 03:53:04,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 284901376 03:53:04 INFO - 2015-11-13 03:53:04,415 DEBUG : BROWSER_OUTPUT: 03:56:06 INFO - 2015-11-13 03:56:06,749 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/dromaeo/cssquery-yui.html (next: http://localhost:51222/tests/dromaeo/cssquery-dojo.html) 03:56:07 INFO - 2015-11-13 03:56:07,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 289173504 03:56:07 INFO - 2015-11-13 03:56:07,004 DEBUG : BROWSER_OUTPUT: 03:56:07 INFO - 2015-11-13 03:56:07,004 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:56:07 INFO - 2015-11-13 03:56:07,004 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:56:07 INFO - 2015-11-13 03:56:07,004 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:56:07 INFO - 2015-11-13 03:56:07,004 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:56:07 INFO - 2015-11-13 03:56:07,005 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2618.9345266368346;2626.553485907396;2628.5531459651856;2694.1782756259345;2720.823146495479;4407.889802754933;4493.3484644726495;4554.157480866038;4567.474740404846;4587.701799383038;4372;4414.735115893049;4441.333799930012;4569.428821397325;4573.474050484196;4111.60939710727;4191.098913733546;4237.258479766044;4281.122369914176;4333.60997510224;4185.330347144458;4220.556841531626;4301.462317210348;4312.331588603755;4362.018545827195;4078.877633670995;4107.609777071173;4190.790460476964;4220.113776107021;4264.445622069111;4190.07818279981;4197.538270790211;4200.474940632421;4219.38818871265;4227.957720422787;4173.64524015459;4177.895552611209;4184.91630167398;4209.536950935395;4284.378765079077;4107.95247211959;4284.978575107136;4334.544872788375;4368.191884501346;4415.227335216325;4721.480637129913;4748.406449193851;4766.475687674353;4785.282207668843;4827.25177597473;4792.664513484057;4793.400824896888;4811.59101476375;4832.1543729847135;4877.609791216694;4271.67962402821;4315.546867578891;4370.781460926941;4455.754933478657;4474.977625111918;4904.901901961941;4934.407871055496;4965.776540055706;4969.055879382906;4983.5763960063805;4450.866474005785;4685.20351540239;4692.601128904082;4696.178168820511;4726.338312636233;4608.147492713859;4688.835890743876;4791.065742180242;4798.808047678054;4874.2444921037295;4656.301554766812;4681.391419115494;4713.9764301178275;4720.787564559603;4721.362616046858;4615.26155815068;4679;4716.339712440261;4729.527047295243;4753.857384278477;3628.818559072036;3683.834227459717;3729.9067523312133;3751.174741556853;3767.56672982605;3292.884749033772;3293.9176520587175;3295.5715756951445;3325.285063711314;3415.8975230743117;4227.260229459832;4284.957150428519;4339.305711086211;4378.474583050054;4468.106378724203;4794.856154315376;4795.592374648124;4820.421549414093;4820.879478013007;4903.509649035139;4399.956000440018;4400.75795831226;4441.222786012435;4488.528704486047;4504.887377815516;4025.6980726445636;4129.215449064668;4175.874723758292;4184.7070705050355;4240.236757383639;4899.118158731462;4911.484294149134;4937.753112344297;4968.180250258667;4994.3507344045765;4801.303810947463;4847.321375007572;4848.5636292733825;4874.195757700081;4921.680090794087;4719;4793.9280910785665;4850.1269771441475;4905.533974272438;4924.261360795909;4740.644451666208;4749.881252968566;4770.522947705202;4789.688670236424;4792.2092854678585;4583.991521865184;4833.419989601271;4843.709377437365;4852.393450818648;4906.533879281463;4317.827286908614;4562.4068871047875;4563.794629241625;4639.698419602715;4670.929936050894;4682.812687492462;4692.601128904082;4704.482506924167;4728.290756386569;4754.881127971828;4378.387025816452;4415;4557.863264102082;4594.081183763194;4622.583967442946;4494.5505449454795;4575.837782064505;4609.492955774929;4614.584687378152;4622.2835460503675;4568.428946381702;4592.311153327028;4599.379083823775;4637.072585482984;4646.558576935186 03:56:07 INFO - 2015-11-13 03:56:07,009 DEBUG : BROWSER_OUTPUT: |1;ext.html;457.4876138724629;476.7044432451879;480.0495019860676;485.0154187000388;500.4420071620145;32342.67657323426;33035.66964330356;33190.66809331906;33408.33183336332;33858;34996.65003349966;35170.12074698134;35237.119072023146;35388.82305588475;35773.642263577356;7725.575093369863;7835.569043702594;7927.762167134995;7932.762017139495;8025.598720064003;7725.304722574967;7779.066512018566;7833.686652533892;7898.328642065431;7898.80252993674;7767.495112817649;7779.844403111934;7803.3367163791145;7825.882611760828;7854.567998760066;7717.49836260644;7802.804929876742;7812.023497062895;7858.567778772165;7941.5632140232265;7650.120236172856;7723.806904827368;7730.690772369098;7783.805404864867;7838.608069596497;33028.33943321144;33435.16412089693;33465.49801752975;33477.33045339104;33486.33027339439;2415.130553000918;2449.2529778417575;2552.5660637691453;2653.40298432853;2823.378856651554;22645.433864153365;23023.1941882035;23227.30318090443;23231.651525227135;24179;1979.2281010405952;2008.2970960163973;2032;2034.0643304079993;2057.177129148353;201300;205984;205995.97002015045;206204;206302;47204.5279547207;47759.761201193774;47885;48369;48499.515004850204;60033.399666002784;61212;61254.38745612576;61314.69342653258;61699;13648.522301719393;14046.297685115704;14104.224267665377;14128.576142715528;14137.222452765196;10594.629187978384;10740;10745.677629671123;10748;10775.78448431027;17107.572310692085;17200.053997030034;17231.56921076958;17245.137743112795;17289.3948711797;7352.77941661751;7571.697132114764;7617.809554761176;7627.580483073484;7640.73257435987;783.1502819440857;801.9639116239666;872.6509396241554;949.2975198353307;962.6245764151986;22122;22308.888455557943;22576.51658317584;22576.66135007976;22812.885935570215;850.4259624753266;952.5999080386255;992.2359782967219;1010.1817527802357;1014.0366651680932;11822.467988940518;11966.64100076999;11997.400129993466;12031.578894738643;12045.795420457884;262965;263160;268098;268647;269440;45169.77415112904;45529.54470455319;45662.315065274044;45765.31352029722;45796;1149.2989276541302;1167.2471256039807;1172.6013155527162;1184.0705046538599;1196.21050106929;23120.84395780238;23453.06187752471;23489.765102348756;23528.529429411657;23693;39531.80234098811;39690.2061958765;40299.395509067974;40378.59621403748;40409.59590404058;248532;248999;250647;250653;250683;27187.72812271852;34202.14494637654;35266.82366588253;36056.63943360533;36083.309169807755;35570.822145889106;35897.820510897276;35924;36392.27215455729;37118.62881371152;29960.250993724458;30384.544231836982;30682.84658576693;30771.69228307688;31108.377832442773;29479.85260073686;29701.257468563457;29801.25496862596;29837;30261.848690756404;30136.095917122522;30385.544216837206;30459.192600924885;30743.53884691687;31129.68870311268;25339.746602534477;26427.339316517242;26550;27052.32369190786;27072.187834365002;19346;19498.122584483448;19605.70591441158;19645.11596978168;19844.801551984296 03:56:07 INFO - 2015-11-13 03:56:07,011 DEBUG : BROWSER_OUTPUT: |2;jquery.html;275.79315513364975;278.18769193953653;278.83409371423994;284.9031329348021;289.995650065249;12201.877981220185;14331.785023224647;14614.634634134152;14840.703185936274;14848.628784280385;14183.574492765209;14398.49605263816;14509.201993890332;14695.706085878275;14763.335649895753;4385;4402.1195760847795;4527.909441811162;4573.176828170945;4588.334691469735;4442.911141777163;4478.373027776114;4485.282354823229;4490.663200259977;4525.637948964091;3173.1591128351006;3295.5715756951563;4424.734515929038;4452.777361131946;4743.644226682995;4887.095887260833;4909.257213689142;4914.8771280718265;4919.188333924916;4951.653384263103;4114.629683328515;4234.25900467417;4238.0888109056705;4267.338562522814;4321.286987647034;17335.65328693419;17373.13134343278;17559.20983555743;17950.551236219068;17957.461276161604;1544.5057581573901;1622.448367555037;1637.8198398176191;1715.4939292908498;1786.0533917023868;10851;10910.727231819188;10932.617358392497;11275.097992160689;11694.415279236004;1347.124369160054;1382.3364784903201;1387.029079644253;1390.2978995607255;1433.362153841541;47142.29286560704;49518.257226141635;49628.503714962746;49686.25470617944;50101.24848127244;7794.3764498839955;7901.604919754104;8156.673733050611;8241.217084376975;8245.299149572234;9938.503074846229;9966.302358834811;10005.849912251322;10027.29808913369;10106.039926206999;6418.807435776934;6458.095866578683;6537.869242615121;6563.3764792344655;6599.439047680905;6439.645819479973;6475.7085931133215;6531.575447595891;6556.311587283267;6604.405603495708;4743.0988112258565;4756.571908528249;4804.159272127434;4806.615470762331;4883.267509873547;1405.4378248700398;1452.1142103316968;1457.9125252484885;1462.4150339864138;1462.8902832287622;318.7641145552275;322.35207233460915;325.34443097159243;765.7779244019283;798.4690181029666;8332.458390204618;8481.915180848237;8748.8687669685;8767.868481972775;8789.736307910773;339.7927264368733;340.5011657921157;345.3059350705051;349.11499349149784;351.3096764857068;4587.931181032287;4636.559526844944;4639.489656137822;4644.767761611906;4758.262469317261;411670;417050;426415;436433;440854;56924.71537642368;57787;57969.71015144897;58044;60214.69892650509;372.5641000029971;373.9383001804726;374.8350725680746;378.143504961263;378.93368660484856;8177.264046235868;8185.795355115932;8192.631331589973;8230.547319897463;8417;26744.19767406981;26948.191554253404;27483.587746184225;27566.5865012029;27765.72234277712;38853.611463885;38860.41709374305;38865.44538218439;39102.6089739099;39874.40188397234;4910.410750709938;5021.899562008813;5176.9741151294;5246.501582349671;5274.947250527445;9542.618295268388;9570.090841370058;9679.177269932135;9803.411795292306;9928.652497162564;7204.3155900189395;8169.836603267782;8363;8494.532800695773;8584.570771461276;6876.449884009367;8024.478408903403;8046.436749427484;8344.16558344185;8580.485170889766;8207.112364156159;8343.666253349798;8559.058503564478;8593.226609605166;8649.956750216208;4886.828960986349;5175.094358487175;5181.948180518298;5205.505476979681;5230.03244399772;8174.141715119827;8311.584420778816;8339.666413343399;8362.12197719255;8516.276116529916 03:56:07 INFO - 2015-11-13 03:56:07,014 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1454.9960527236199;1501.534524297468;1517.4764706176372;1530.204293767241;1570.1835045776193;5920.763169473226;6112.358202388741;6560.868782624345;6854.794356169316;6856.314368563148;6305.3064162942155;6420.967895160517;6543.24752653445;6553.77061802837;6558.442532384753;1779.5373202967257;1789.6510180514804;1795.9461216163536;1808.3309175605045;1809.9185536650882;1805.0523475175507;1818.672638924993;1832.2854086906118;1834.0371305064814;1851.6389304085708;1797.2002458905793;1821.6356728654255;1822.4168266154836;1829.277435413011;1845.2342277954633;1804.242218268324;1805.0794095011508;1843.0876716025587;1866.990665046666;1867.7665291838384;1828.7714035745532;1832.743415921772;1843.5759775251768;1843.6128413033146;1863.0777765006274;6592.86814263712;6692.163479565054;6726.192856857159;6745.831354216135;6758;3795.8291876865605;3891.6886649068006;3896.376579747227;3929.5873933236885;3942.3298039333094;2204.9889750551147;2231.3752149398033;2363.550925324183;2425.333033415807;2439.499902519997;777.996110019452;795.7533164718956;803.3292201012162;806.7095845495617;810;8548.187922147386;8559.101294364064;8586.570671466465;8628.007779105421;8668.393212475192;3396.5924089109467;3433.9656603434146;3468.4450487921813;3484.6341134181052;3524.823758812049;7687.308142267223;7692.307692307719;7732.342750866239;7757.340626046736;7772.106207786177;3940.645341919241;3942.250972315251;3946.2699400610977;3959.8812035638975;4001.4998125234347;3598.5321908151773;3613.6567026132475;3616.710663146942;3619.619939906272;3641.635836416337;3044.497657886468;3056.9847150764103;3090.5518699788404;3098.5816914716675;3112.50199968004;975.5512464266517;978.5694294510392;981.563204374061;981.6269817469316;989.317371013998;846.0820010288905;1099.14816017587;1099.8405231241425;1136.3977092141179;1137.3573930729112;6172.444479996821;6209.65846878417;6236.345183755731;6241.906371404432;6256.280527739368;342.52218155673194;347.6731872040274;353.0696614421019;354.59044803252283;356.3638904555356;4789.784459699322;4848.0788650157065;4851.854444366674;4862.95137048625;4868.9269660955115;7285.562866228043;7326.3040011198855;7568.772936811794;7656.425768067417;7950.0857401398425;7795.844083118419;7799.883001754978;7820.061592608809;7826.608669566499;7850.725224617111;6071.362506936796;6143.692815359214;6249.500039996789;6259.937400626027;6286.277078135981;5987.7604895805425;6010.609310394811;6011.879762404815;6105.145279660762;6126.693665316806;6559.8032059038305;6791.524593278423;6805.6937437816405;7017.649117544001;7083.256258092826;6960.269171736894;7236.710531578678;7269.3094156055095;7272.200057993722;7315.926840731738;5875.148103525051;5883.705814709162;5889.5582831286965;5892.1161825726485;5941.673207973603;6239.251289845248;6248.9062664059165;6296.559240853279;6354.205724284465;6416.807495775134;5603.355614104267;5862.882742345215;5933.465988061095;6028.3971602839365;6034.125051867367;5726.398728133652;5755.8561035974435;5758.769649214152;5804.361520232686;5923.526117910643;5860.120981852586;5919.852003699942;5930.7627694893445;5956.344802071682;6005.909911351246;5309.150535914235;5355.973220133875;5375.059364611256;5391.056565101013;5396.757145928521;5402.972985135049;5435.429279925551;5437.728113594384;5448.536874365724;5470.261514695465 03:56:07 INFO - 2015-11-13 03:56:07,019 DEBUG : BROWSER_OUTPUT: |4;prototype.html;254.63587070489206;256.95117927593753;266.0714107763904;266.3022880054258;267.09987342655256;5162.096633089203;5205.505476979685;5319.92020119698;5331.120365139747;5360.463953604638;5103.591712662987;5275.709835959021;5294.735263236842;5322.0154271459805;5357.08929481988;4130.277201489742;4150.190712810995;4175.290200665879;4209.831606735727;4214.431051807997;4142.523609784883;4147.1705658868195;4156.667466602665;4181.414601955728;4249.405083288342;3895;4107.527634322047;4146.1914926589325;4179.185058913513;4204.789760511978;4052.4326594276827;4058.3100872851687;4071.531773846001;4116.320807066831;4148.564400737924;3446.293509830479;3458.8270586470576;3482.2513159670793;3505;3519.296140771856;4935.80256789728;5035.798568057273;5121.513456221653;5141.6143789215585;5180.248863914711;4459.710118842265;4507.706999045052;4540.568645978627;4548.840790572347;4596.241620132708;5594.104943209108;5597.188407680864;5645.689487078209;5661;5677.176809362661;3692.132348898007;3700.40793473043;3711.2763011212824;3724.7578907370935;3742.1954279829965;5693.28833895763;5801.361850196475;5830.4169583041785;5920.851978700523;5943.494802941756;3753.230587729509;3763.473113764075;3766.3597188478025;3792.829322680486;3813.771173729585;3803.372443546784;3804.1060350817534;3809.9047523811573;3822.617738226211;3877.0501227199516;4460.152571011562;4473.821047158077;4481.395011673448;4536.092781443725;4559.680822342404;5368.436314187033;5406.540444062299;5500.532454741392;5536.141898005815;5655.886882262332;1318.228836130855;1339.598120563827;1341.2891167681144;1348.3864841497095;1366.125679565079;839.8446287436843;861.9353548483764;864.7362554420962;868.405142477405;889.4485419040236;5291.126964050965;5303.231031500411;5371.248025276464;5391.110466772939;5402.6758394496455;5799;5805.419458054161;5816.098504731774;5899.852503687356;5906.7637294508595;5288.153895376721;5298.761555730001;5357.383900851452;5386.13821788512;5401.405845357008;3022.3653032862903;3105.223694076481;3140.262038420969;3189.6012998375204;3194.2653189766484;5981.700914954235;5999.130126131774;6025.879482410327;6041.909371359433;6044.486218671374;5952.166696662471;5958.880822383528;5974.103884417372;6052.788152414644;6073.817785466443;5856.94143058581;5955.910661340084;5961.642301461839;6041.24484439445;6082.057281121433;5811.4479124483105;5824.970875145597;5883;5899.262592175978;5945.078512830518;5633.943660563342;5709.543236540983;5738.081906894877;5756.42435756421;5785.942140578709;5970.253718285215;5989.221401217814;6028.3971602839365;6073.423024812636;6099.8780024398375;3700.2414505025868;3749.9250015000093;3775;3781.6029316921326;3804.20111776519;5728.083506638918;5774.220480235114;5780.2485676863425;5815;5884;5569.944300556943;5595.384507704231;5611.438856114356;5669.603127781016;5703.372629010889;5587.245721827664;5592.077307244259;5626;5630.662160270397;5686.9715651421475;5281.973590132025;5491.148871924858;5492.231087647812;5496.422875598005;5537.584681148849;5604.495595396434;5612.7193640317;5635.6618602883955;5662.2639056922335;5685.658860468385;5468.699221542854;5474.479924407175;5481.177823326533;5572.219889215432;5577.6653400796085 03:56:07 INFO - 2015-11-13 03:56:07,020 DEBUG : BROWSER_OUTPUT: |5;yui.html;619.6096459230685;622.6855438003807;634.629658226524;648.7956293767465;650.2327253840468;11178.21752477326;11392.430378481075;11900.7619847603;11947.64157075287;12131.636050918487;10944.890551094486;11029.889701103006;11084.390358530298;11266.549338026489;11288.604898828542;583.1748076471787;588.4556784973903;746.5669911451345;755.2296657409453;775.244136966456;750.9586972716498;753.1752730759837;764.598585742484;766.9309762121408;781.9726309579166;788.6175205025557;798.2616080125889;800.2597597222575;801.3749275565068;801.8556659801234;794.1978601612356;794.9403794715362;797.7965618767236;800.2277801921174;800.671724592917;588.8881112588595;589.3576002157625;589.6226415094343;595.8808238352347;598.1715324275866;10374.481275936172;10490.842637360445;10594.099501542378;10624.043836054714;10653.25427220095;9425.104615061558;9586.328956973015;9981.70054898347;10120.848187277197;10218.080372766412;7666.348360389374;7821.100573434071;8064.395170362246;8070.192980701941;8474.74575762728;2781.5549512078173;2791.064993227251;2827.6889542150348;2829.6604407471027;2840.076974983139;40865.387019194735;40973.97565060868;41068.794656026825;41184.1763164738;41533.376999344735;7651.464397492122;7837.2162783722315;7901.130875603679;8075.636596353178;8092.959535202404;16250.349986000663;16304.673906521803;16480.0935948524;16486;16531.173441327886;5240.737963101829;5268.868278293074;5448.182772584065;5497.47773961473;6061.454469097803;3094.5512900629283;3104.9534256986162;3143.1042152986747;3178.523221516745;3241.4813629819587;2308.9653655195184;2342.7071616047992;2344.5896968030524;2363.2437619961447;2365.6451532269953;338.1546134663342;338.52606351108153;342.5683638615363;345.2335814491824;348.6548317165987;418.48317328099773;470.88698712309485;474.70093840880713;512.4439982618826;530.3688610553506;5882.705864706748;6354.459870910932;6390.447004539807;6390.584612000205;6604.966975165094;403.50570551074696;446.533372625607;485.74498388345694;509.54395815744704;532.4568939681503;2914.4753944290233;3119.547665588477;3149.4645910195322;3176.904692859218;3201.183698156955;48916.510834891196;50057.49942500601;50430.243546346836;50828.745856270485;50898.74550627223;44219.55780442154;44387.55612443834;44761.32858007133;44780.77609611996;45462.54537454583;39917.80041099834;40105.39841902374;40252.79873600672;40473.79763101166;40529.79735101364;6335.429811317003;6404.295527491879;6426;6447.806565803034;6553.770618028346;29148.854255728587;29302;29806.70193298039;29973.550396744504;30214.093577192718;37620;38059.80970095243;38293.4255986166;38645.6135438642;38964.41553376645;6541.70562324687;6614.404703576702;6623.205215374186;6700.430463410665;6982.441404687511;9401.294902882448;9423.717288481357;9451.385659932082;9474.85787713171;9510.38182518134;8876.156765107304;8937.329700272636;8939.195472407515;8942.239909607757;8956.462612243286;8784.95607521984;8871.556422178735;8885.200331970154;8911.15344042315;8929.196372326522;8811;8857.911420885966;8875.644974200959;8883;8895.955520222358;7445.739399121005;7531;8021.382374500665;8081.595920204084;8101.098835204852;7534.773956781305;7574.242575742602;7645.935447841162;7811.414143939341;7823.647935842787 03:56:07 INFO - 2015-11-13 03:56:07,020 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:56:07 INFO - 2015-11-13 03:56:07,021 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:56:07 INFO - 2015-11-13 03:56:07,021 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,299 03:56:07 INFO - 2015-11-13 03:56:07,021 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:56:07 INFO - 2015-11-13 03:56:07,021 DEBUG : BROWSER_OUTPUT: __startTimestamp1447415767002__endTimestamp 03:56:07 INFO - 2015-11-13 03:56:07,021 DEBUG : BROWSER_OUTPUT: 03:56:07 INFO - 2015-11-13 03:56:07,021 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:56:07 INFO - 2015-11-13 03:56:07,022 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:56:07 INFO - 2015-11-13 03:56:07,022 DEBUG : BROWSER_OUTPUT: 03:56:07 INFO - 2015-11-13 03:56:07,022 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4447.05 Median:4573.47 stddev:474.18 (10.4%) stddev-sans-first:453.43 03:56:07 INFO - 2015-11-13 03:56:07,022 DEBUG : BROWSER_OUTPUT: Values: 2618.9 2626.6 2628.6 2694.2 2720.8 4407.9 4493.3 4554.2 4567.5 4587.7 4372.0 4414.7 4441.3 4569.4 4573.5 4111.6 4191.1 4237.3 4281.1 4333.6 4185.3 4220.6 4301.5 4312.3 4362.0 4078.9 4107.6 4190.8 4220.1 4264.4 4190.1 4197.5 4200.5 4219.4 4228.0 4173.6 4177.9 4184.9 4209.5 4284.4 4108.0 4285.0 4334.5 4368.2 4415.2 4721.5 4748.4 4766.5 4785.3 4827.3 4792.7 4793.4 4811.6 4832.2 4877.6 4271.7 4315.5 4370.8 4455.8 4475.0 4904.9 4934.4 4965.8 4969.1 4983.6 4450.9 4685.2 4692.6 4696.2 4726.3 4608.1 4688.8 4791.1 4798.8 4874.2 4656.3 4681.4 4714.0 4720.8 4721.4 4615.3 4679.0 4716.3 4729.5 4753.9 3628.8 3683.8 3729.9 3751.2 3767.6 3292.9 3293.9 3295.6 3325.3 3415.9 4227.3 4285.0 4339.3 4378.5 4468.1 4794.9 4795.6 4820.4 4820.9 4903.5 4400.0 4400.8 4441.2 4488.5 4504.9 4025.7 4129.2 4175.9 4184.7 4240.2 4899.1 4911.5 4937.8 4968.2 4994.4 4801.3 4847.3 4848.6 4874.2 4921.7 4719.0 4793.9 4850.1 4905.5 4924.3 4740.6 4749.9 4770.5 4789.7 4792.2 4584.0 4833.4 4843.7 4852.4 4906.5 4317.8 4562.4 4563.8 4639.7 4670.9 4682.8 4692.6 4704.5 4728.3 4754.9 4378.4 4415.0 4557.9 4594.1 4622.6 4494.6 4575.8 4609.5 4614.6 4622.3 4568.4 4592.3 4599.4 4637.1 4646.6 03:56:07 INFO - 2015-11-13 03:56:07,022 DEBUG : BROWSER_OUTPUT: 03:56:07 INFO - 2015-11-13 03:56:07,023 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38970.19 Median:30940.04 stddev:63221.38 (204.3%) stddev-sans-first:63332.60 03:56:07 INFO - 2015-11-13 03:56:07,024 DEBUG : BROWSER_OUTPUT: Values: 457.5 476.7 480.0 485.0 500.4 32342.7 33035.7 33190.7 33408.3 33858.0 34996.7 35170.1 35237.1 35388.8 35773.6 7725.6 7835.6 7927.8 7932.8 8025.6 7725.3 7779.1 7833.7 7898.3 7898.8 7767.5 7779.8 7803.3 7825.9 7854.6 7717.5 7802.8 7812.0 7858.6 7941.6 7650.1 7723.8 7730.7 7783.8 7838.6 33028.3 33435.2 33465.5 33477.3 33486.3 2415.1 2449.3 2552.6 2653.4 2823.4 22645.4 23023.2 23227.3 23231.7 24179.0 1979.2 2008.3 2032.0 2034.1 2057.2 201300.0 205984.0 205996.0 206204.0 206302.0 47204.5 47759.8 47885.0 48369.0 48499.5 60033.4 61212.0 61254.4 61314.7 61699.0 13648.5 14046.3 14104.2 14128.6 14137.2 10594.6 10740.0 10745.7 10748.0 10775.8 17107.6 17200.1 17231.6 17245.1 17289.4 7352.8 7571.7 7617.8 7627.6 7640.7 783.2 802.0 872.7 949.3 962.6 22122.0 22308.9 22576.5 22576.7 22812.9 850.4 952.6 992.2 1010.2 1014.0 11822.5 11966.6 11997.4 12031.6 12045.8 262965.0 263160.0 268098.0 268647.0 269440.0 45169.8 45529.5 45662.3 45765.3 45796.0 1149.3 1167.2 1172.6 1184.1 1196.2 23120.8 23453.1 23489.8 23528.5 23693.0 39531.8 39690.2 40299.4 40378.6 40409.6 248532.0 248999.0 250647.0 250653.0 250683.0 27187.7 34202.1 35266.8 36056.6 36083.3 35570.8 35897.8 35924.0 36392.3 37118.6 29960.3 30384.5 30682.8 30771.7 31108.4 29479.9 29701.3 29801.3 29837.0 30261.8 30136.1 30385.5 30459.2 30743.5 31129.7 25339.7 26427.3 26550.0 27052.3 27072.2 19346.0 19498.1 19605.7 19645.1 19844.8 03:56:07 INFO - 2015-11-13 03:56:07,024 DEBUG : BROWSER_OUTPUT: 03:56:07 INFO - 2015-11-13 03:56:07,025 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22118.00 Median:4612.45 stddev:69775.42 (1512.8%) stddev-sans-first:69951.89 03:56:07 INFO - 2015-11-13 03:56:07,026 DEBUG : BROWSER_OUTPUT: Values: 275.8 278.2 278.8 284.9 290.0 12201.9 14331.8 14614.6 14840.7 14848.6 14183.6 14398.5 14509.2 14695.7 14763.3 4385.0 4402.1 4527.9 4573.2 4588.3 4442.9 4478.4 4485.3 4490.7 4525.6 3173.2 3295.6 4424.7 4452.8 4743.6 4887.1 4909.3 4914.9 4919.2 4951.7 4114.6 4234.3 4238.1 4267.3 4321.3 17335.7 17373.1 17559.2 17950.6 17957.5 1544.5 1622.4 1637.8 1715.5 1786.1 10851.0 10910.7 10932.6 11275.1 11694.4 1347.1 1382.3 1387.0 1390.3 1433.4 47142.3 49518.3 49628.5 49686.3 50101.2 7794.4 7901.6 8156.7 8241.2 8245.3 9938.5 9966.3 10005.8 10027.3 10106.0 6418.8 6458.1 6537.9 6563.4 6599.4 6439.6 6475.7 6531.6 6556.3 6604.4 4743.1 4756.6 4804.2 4806.6 4883.3 1405.4 1452.1 1457.9 1462.4 1462.9 318.8 322.4 325.3 765.8 798.5 8332.5 8481.9 8748.9 8767.9 8789.7 339.8 340.5 345.3 349.1 351.3 4587.9 4636.6 4639.5 4644.8 4758.3 411670.0 417050.0 426415.0 436433.0 440854.0 56924.7 57787.0 57969.7 58044.0 60214.7 372.6 373.9 374.8 378.1 378.9 8177.3 8185.8 8192.6 8230.5 8417.0 26744.2 26948.2 27483.6 27566.6 27765.7 38853.6 38860.4 38865.4 39102.6 39874.4 4910.4 5021.9 5177.0 5246.5 5274.9 9542.6 9570.1 9679.2 9803.4 9928.7 7204.3 8169.8 8363.0 8494.5 8584.6 6876.4 8024.5 8046.4 8344.2 8580.5 8207.1 8343.7 8559.1 8593.2 8650.0 4886.8 5175.1 5181.9 5205.5 5230.0 8174.1 8311.6 8339.7 8362.1 8516.3 03:56:07 INFO - 2015-11-13 03:56:07,027 DEBUG : BROWSER_OUTPUT: 03:56:07 INFO - 2015-11-13 03:56:07,027 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4542.68 Median:5869.02 stddev:2382.86 (40.6%) stddev-sans-first:2378.25 03:56:07 INFO - 2015-11-13 03:56:07,028 DEBUG : BROWSER_OUTPUT: Values: 1455.0 1501.5 1517.5 1530.2 1570.2 5920.8 6112.4 6560.9 6854.8 6856.3 6305.3 6421.0 6543.2 6553.8 6558.4 1779.5 1789.7 1795.9 1808.3 1809.9 1805.1 1818.7 1832.3 1834.0 1851.6 1797.2 1821.6 1822.4 1829.3 1845.2 1804.2 1805.1 1843.1 1867.0 1867.8 1828.8 1832.7 1843.6 1843.6 1863.1 6592.9 6692.2 6726.2 6745.8 6758.0 3795.8 3891.7 3896.4 3929.6 3942.3 2205.0 2231.4 2363.6 2425.3 2439.5 778.0 795.8 803.3 806.7 810.0 8548.2 8559.1 8586.6 8628.0 8668.4 3396.6 3434.0 3468.4 3484.6 3524.8 7687.3 7692.3 7732.3 7757.3 7772.1 3940.6 3942.3 3946.3 3959.9 4001.5 3598.5 3613.7 3616.7 3619.6 3641.6 3044.5 3057.0 3090.6 3098.6 3112.5 975.6 978.6 981.6 981.6 989.3 846.1 1099.1 1099.8 1136.4 1137.4 6172.4 6209.7 6236.3 6241.9 6256.3 342.5 347.7 353.1 354.6 356.4 4789.8 4848.1 4851.9 4863.0 4868.9 7285.6 7326.3 7568.8 7656.4 7950.1 7795.8 7799.9 7820.1 7826.6 7850.7 6071.4 6143.7 6249.5 6259.9 6286.3 5987.8 6010.6 6011.9 6105.1 6126.7 6559.8 6791.5 6805.7 7017.6 7083.3 6960.3 7236.7 7269.3 7272.2 7315.9 5875.1 5883.7 5889.6 5892.1 5941.7 6239.3 6248.9 6296.6 6354.2 6416.8 5603.4 5862.9 5933.5 6028.4 6034.1 5726.4 5755.9 5758.8 5804.4 5923.5 5860.1 5919.9 5930.8 5956.3 6005.9 5309.2 5356.0 5375.1 5391.1 5396.8 5403.0 5435.4 5437.7 5448.5 5470.3 03:56:07 INFO - 2015-11-13 03:56:07,028 DEBUG : BROWSER_OUTPUT: 03:56:07 INFO - 2015-11-13 03:56:07,028 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4671.56 Median:5364.45 stddev:1443.44 (26.9%) stddev-sans-first:1408.90 03:56:07 INFO - 2015-11-13 03:56:07,030 DEBUG : BROWSER_OUTPUT: Values: 254.6 257.0 266.1 266.3 267.1 5162.1 5205.5 5319.9 5331.1 5360.5 5103.6 5275.7 5294.7 5322.0 5357.1 4130.3 4150.2 4175.3 4209.8 4214.4 4142.5 4147.2 4156.7 4181.4 4249.4 3895.0 4107.5 4146.2 4179.2 4204.8 4052.4 4058.3 4071.5 4116.3 4148.6 3446.3 3458.8 3482.3 3505.0 3519.3 4935.8 5035.8 5121.5 5141.6 5180.2 4459.7 4507.7 4540.6 4548.8 4596.2 5594.1 5597.2 5645.7 5661.0 5677.2 3692.1 3700.4 3711.3 3724.8 3742.2 5693.3 5801.4 5830.4 5920.9 5943.5 3753.2 3763.5 3766.4 3792.8 3813.8 3803.4 3804.1 3809.9 3822.6 3877.1 4460.2 4473.8 4481.4 4536.1 4559.7 5368.4 5406.5 5500.5 5536.1 5655.9 1318.2 1339.6 1341.3 1348.4 1366.1 839.8 861.9 864.7 868.4 889.4 5291.1 5303.2 5371.2 5391.1 5402.7 5799.0 5805.4 5816.1 5899.9 5906.8 5288.2 5298.8 5357.4 5386.1 5401.4 3022.4 3105.2 3140.3 3189.6 3194.3 5981.7 5999.1 6025.9 6041.9 6044.5 5952.2 5958.9 5974.1 6052.8 6073.8 5856.9 5955.9 5961.6 6041.2 6082.1 5811.4 5825.0 5883.0 5899.3 5945.1 5633.9 5709.5 5738.1 5756.4 5785.9 5970.3 5989.2 6028.4 6073.4 6099.9 3700.2 3749.9 3775.0 3781.6 3804.2 5728.1 5774.2 5780.2 5815.0 5884.0 5569.9 5595.4 5611.4 5669.6 5703.4 5587.2 5592.1 5626.0 5630.7 5687.0 5282.0 5491.1 5492.2 5496.4 5537.6 5604.5 5612.7 5635.7 5662.3 5685.7 5468.7 5474.5 5481.2 5572.2 5577.7 03:56:07 INFO - 2015-11-13 03:56:07,030 DEBUG : BROWSER_OUTPUT: 03:56:07 INFO - 2015-11-13 03:56:07,030 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11486.54 Median:3040.33 stddev:13925.01 (458.0%) stddev-sans-first:13940.17 03:56:07 INFO - 2015-11-13 03:56:07,034 DEBUG : BROWSER_OUTPUT: Values: 619.6 622.7 634.6 648.8 650.2 11178.2 11392.4 11900.8 11947.6 12131.6 10944.9 11029.9 11084.4 11266.5 11288.6 583.2 588.5 746.6 755.2 775.2 751.0 753.2 764.6 766.9 782.0 788.6 798.3 800.3 801.4 801.9 794.2 794.9 797.8 800.2 800.7 588.9 589.4 589.6 595.9 598.2 10374.5 10490.8 10594.1 10624.0 10653.3 9425.1 9586.3 9981.7 10120.8 10218.1 7666.3 7821.1 8064.4 8070.2 8474.7 2781.6 2791.1 2827.7 2829.7 2840.1 40865.4 40974.0 41068.8 41184.2 41533.4 7651.5 7837.2 7901.1 8075.6 8093.0 16250.3 16304.7 16480.1 16486.0 16531.2 5240.7 5268.9 5448.2 5497.5 6061.5 3094.6 3105.0 3143.1 3178.5 3241.5 2309.0 2342.7 2344.6 2363.2 2365.6 338.2 338.5 342.6 345.2 348.7 418.5 470.9 474.7 512.4 530.4 5882.7 6354.5 6390.4 6390.6 6605.0 403.5 446.5 485.7 509.5 532.5 2914.5 3119.5 3149.5 3176.9 3201.2 48916.5 50057.5 50430.2 50828.7 50898.7 44219.6 44387.6 44761.3 44780.8 45462.5 39917.8 40105.4 40252.8 40473.8 40529.8 6335.4 6404.3 6426.0 6447.8 6553.8 29148.9 29302.0 29806.7 29973.6 30214.1 37620.0 38059.8 38293.4 38645.6 38964.4 6541.7 6614.4 6623.2 6700.4 6982.4 9401.3 9423.7 9451.4 9474.9 9510.4 8876.2 8937.3 8939.2 8942.2 8956.5 8785.0 8871.6 8885.2 8911.2 8929.2 8811.0 8857.9 8875.6 8883.0 8896.0 7445.7 7531.0 8021.4 8081.6 8101.1 7534.8 7574.2 7645.9 7811.4 7823.6 03:56:07 INFO - 2015-11-13 03:56:07,034 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:56:07 INFO - 2015-11-13 03:56:07,034 DEBUG : BROWSER_OUTPUT: 03:56:07 INFO - 2015-11-13 03:56:07,740 INFO : Browser exited with error code: 0 03:56:07 INFO - 2015-11-13 03:56:07,772 INFO : Completed test dromaeo_css (00:18:32) 03:56:07 INFO - 2015-11-13 03:56:07,772 INFO : Starting test kraken 03:56:07 INFO - 2015-11-13 03:56:07,772 DEBUG : operating with platform_type : mac_ 03:56:07 INFO - 2015-11-13 03:56:07,772 INFO : Initialising browser for kraken test... 03:56:07 INFO - 2015-11-13 03:56:07,787 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/tmpcKxTL6/profile http://localhost:51222/getInfo.html 03:56:11 INFO - 2015-11-13 03:56:11,125 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:56:11 INFO - 2015-11-13 03:56:11,126 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:56:11 INFO - 2015-11-13 03:56:11,126 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:56:11 INFO - 2015-11-13 03:56:11,126 DEBUG : BROWSER_OUTPUT: __metrics 03:56:11 INFO - 2015-11-13 03:56:11,819 INFO : Browser initialized. 03:56:11 INFO - 2015-11-13 03:56:11,819 INFO : Running cycle 1/1 for kraken test... 03:56:11 INFO - 2015-11-13 03:56:11,819 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/tmpcKxTL6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:56:24 INFO - 2015-11-13 03:56:24,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 241229824 03:56:24 INFO - 2015-11-13 03:56:24,018 DEBUG : BROWSER_OUTPUT: 03:56:26 INFO - 2015-11-13 03:56:26,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51222/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:27 INFO - 2015-11-13 03:56:27,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 259850240 03:56:27 INFO - 2015-11-13 03:56:27,516 DEBUG : BROWSER_OUTPUT: 03:56:30 INFO - 2015-11-13 03:56:30,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51222/tests/kraken/driver.html?testName=audio-dft) 03:56:31 INFO - 2015-11-13 03:56:31,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 266952704 03:56:31 INFO - 2015-11-13 03:56:31,172 DEBUG : BROWSER_OUTPUT: 03:56:34 INFO - 2015-11-13 03:56:34,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51222/tests/kraken/driver.html?testName=audio-fft) 03:56:35 INFO - 2015-11-13 03:56:35,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 266915840 03:56:35 INFO - 2015-11-13 03:56:35,056 DEBUG : BROWSER_OUTPUT: 03:56:37 INFO - 2015-11-13 03:56:37,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51222/tests/kraken/driver.html?testName=audio-oscillator) 03:56:37 INFO - 2015-11-13 03:56:37,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 267231232 03:56:37 INFO - 2015-11-13 03:56:37,845 DEBUG : BROWSER_OUTPUT: 03:56:40 INFO - 2015-11-13 03:56:40,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51222/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:56:40 INFO - 2015-11-13 03:56:40,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 267829248 03:56:40 INFO - 2015-11-13 03:56:40,828 DEBUG : BROWSER_OUTPUT: 03:56:44 INFO - 2015-11-13 03:56:44,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51222/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:44 INFO - 2015-11-13 03:56:44,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 265539584 03:56:44 INFO - 2015-11-13 03:56:44,921 DEBUG : BROWSER_OUTPUT: 03:56:48 INFO - 2015-11-13 03:56:48,543 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51222/tests/kraken/driver.html?testName=imaging-desaturate) 03:56:49 INFO - 2015-11-13 03:56:49,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 266170368 03:56:49 INFO - 2015-11-13 03:56:49,134 DEBUG : BROWSER_OUTPUT: 03:56:52 INFO - 2015-11-13 03:56:52,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51222/tests/kraken/driver.html?testName=json-parse-financial) 03:56:53 INFO - 2015-11-13 03:56:53,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 267390976 03:56:53 INFO - 2015-11-13 03:56:53,013 DEBUG : BROWSER_OUTPUT: 03:56:54 INFO - 2015-11-13 03:56:54,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51222/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:56:55 INFO - 2015-11-13 03:56:55,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 268214272 03:56:55 INFO - 2015-11-13 03:56:55,357 DEBUG : BROWSER_OUTPUT: 03:56:57 INFO - 2015-11-13 03:56:57,354 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:57 INFO - 2015-11-13 03:56:57,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 267927552 03:56:57 INFO - 2015-11-13 03:56:57,988 DEBUG : BROWSER_OUTPUT: 03:57:00 INFO - 2015-11-13 03:57:00,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:00 INFO - 2015-11-13 03:57:00,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 267960320 03:57:00 INFO - 2015-11-13 03:57:00,935 DEBUG : BROWSER_OUTPUT: 03:57:03 INFO - 2015-11-13 03:57:03,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:04 INFO - 2015-11-13 03:57:04,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 268513280 03:57:04 INFO - 2015-11-13 03:57:04,522 DEBUG : BROWSER_OUTPUT: 03:57:07 INFO - 2015-11-13 03:57:07,570 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:08 INFO - 2015-11-13 03:57:08,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 267935744 03:57:08 INFO - 2015-11-13 03:57:08,159 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51222/tests/kraken/driver.html?testName=ai-astar) 03:57:10 INFO - 2015-11-13 03:57:10,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 268529664 03:57:10 INFO - 2015-11-13 03:57:10,334 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,334 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:57:10 INFO - 2015-11-13 03:57:10,334 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:57:10 INFO - 2015-11-13 03:57:10,334 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:57:10 INFO - 2015-11-13 03:57:10,334 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:57:10 INFO - 2015-11-13 03:57:10,334 DEBUG : BROWSER_OUTPUT: |0;ai-astar;130;125;135;138;134;144;136;134;136;135 03:57:10 INFO - 2015-11-13 03:57:10,334 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;183;162;190;204;157;182;178;157;197;169 03:57:10 INFO - 2015-11-13 03:57:10,334 DEBUG : BROWSER_OUTPUT: |2;audio-dft;200;202;213;204;198;193;202;203;205;203 03:57:10 INFO - 2015-11-13 03:57:10,334 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;88;100;148;85;88;90;86;122;80 03:57:10 INFO - 2015-11-13 03:57:10,335 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;109;109;150;108;108;109;152;114;108;152 03:57:10 INFO - 2015-11-13 03:57:10,335 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;142;142;149;149;157;150;149;148;143 03:57:10 INFO - 2015-11-13 03:57:10,335 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;157;157;164;158;157;156;156;157;157;156 03:57:10 INFO - 2015-11-13 03:57:10,335 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;134;129;137;118;120;123;123;124;128 03:57:10 INFO - 2015-11-13 03:57:10,335 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;73;78;77;78;78;77;84;80;81 03:57:10 INFO - 2015-11-13 03:57:10,336 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;78;81;83;82;83;81;83;81;82 03:57:10 INFO - 2015-11-13 03:57:10,336 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;101;105;109;111;110;109;107;105;106;107 03:57:10 INFO - 2015-11-13 03:57:10,336 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;152;160;161;160;178;151;154;158;161;180 03:57:10 INFO - 2015-11-13 03:57:10,336 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;192;196;196;194;194;193;195;197;192;181 03:57:10 INFO - 2015-11-13 03:57:10,336 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;80;86;92;88;88;90;91;91;89;89 03:57:10 INFO - 2015-11-13 03:57:10,337 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:57:10 INFO - 2015-11-13 03:57:10,337 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:57:10 INFO - 2015-11-13 03:57:10,337 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,758 03:57:10 INFO - 2015-11-13 03:57:10,337 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:57:10 INFO - 2015-11-13 03:57:10,337 DEBUG : BROWSER_OUTPUT: __startTimestamp1447415830330__endTimestamp 03:57:10 INFO - 2015-11-13 03:57:10,338 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,338 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:57:10 INFO - 2015-11-13 03:57:10,338 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:57:10 INFO - 2015-11-13 03:57:10,338 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,338 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:134.70 Median:135.50 stddev:4.92 (3.6%) stddev-sans-first:4.92 03:57:10 INFO - 2015-11-13 03:57:10,339 DEBUG : BROWSER_OUTPUT: Values: 130.0 125.0 135.0 138.0 134.0 144.0 136.0 134.0 136.0 135.0 03:57:10 INFO - 2015-11-13 03:57:10,339 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,339 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:177.90 Median:182.50 stddev:16.47 (9.0%) stddev-sans-first:17.36 03:57:10 INFO - 2015-11-13 03:57:10,339 DEBUG : BROWSER_OUTPUT: Values: 183.0 162.0 190.0 204.0 157.0 182.0 178.0 157.0 197.0 169.0 03:57:10 INFO - 2015-11-13 03:57:10,339 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,339 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:202.30 Median:203.00 stddev:5.12 (2.5%) stddev-sans-first:5.36 03:57:10 INFO - 2015-11-13 03:57:10,340 DEBUG : BROWSER_OUTPUT: Values: 200.0 202.0 213.0 204.0 198.0 193.0 202.0 203.0 205.0 203.0 03:57:10 INFO - 2015-11-13 03:57:10,341 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,341 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:96.80 Median:85.50 stddev:21.74 (25.4%) stddev-sans-first:22.30 03:57:10 INFO - 2015-11-13 03:57:10,341 DEBUG : BROWSER_OUTPUT: Values: 81.0 88.0 100.0 148.0 85.0 88.0 90.0 86.0 122.0 80.0 03:57:10 INFO - 2015-11-13 03:57:10,342 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,342 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:121.90 Median:111.50 stddev:20.39 (18.3%) stddev-sans-first:21.09 03:57:10 INFO - 2015-11-13 03:57:10,342 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 150.0 108.0 108.0 109.0 152.0 114.0 108.0 152.0 03:57:10 INFO - 2015-11-13 03:57:10,342 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,342 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:147.80 Median:149.00 stddev:4.54 (3.0%) stddev-sans-first:4.80 03:57:10 INFO - 2015-11-13 03:57:10,342 DEBUG : BROWSER_OUTPUT: Values: 149.0 142.0 142.0 149.0 149.0 157.0 150.0 149.0 148.0 143.0 03:57:10 INFO - 2015-11-13 03:57:10,343 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,343 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:157.50 Median:157.00 stddev:2.37 (1.5%) stddev-sans-first:2.51 03:57:10 INFO - 2015-11-13 03:57:10,343 DEBUG : BROWSER_OUTPUT: Values: 157.0 157.0 164.0 158.0 157.0 156.0 156.0 157.0 157.0 156.0 03:57:10 INFO - 2015-11-13 03:57:10,343 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,343 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:125.40 Median:126.00 stddev:6.50 (5.2%) stddev-sans-first:6.32 03:57:10 INFO - 2015-11-13 03:57:10,344 DEBUG : BROWSER_OUTPUT: Values: 118.0 134.0 129.0 137.0 118.0 120.0 123.0 123.0 124.0 128.0 03:57:10 INFO - 2015-11-13 03:57:10,344 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,344 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:77.70 Median:78.00 stddev:3.71 (4.8%) stddev-sans-first:3.05 03:57:10 INFO - 2015-11-13 03:57:10,344 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 78.0 77.0 78.0 78.0 77.0 84.0 80.0 81.0 03:57:10 INFO - 2015-11-13 03:57:10,344 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,345 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:80.80 Median:82.00 stddev:2.82 (3.4%) stddev-sans-first:1.59 03:57:10 INFO - 2015-11-13 03:57:10,345 DEBUG : BROWSER_OUTPUT: Values: 74.0 78.0 81.0 83.0 82.0 83.0 81.0 83.0 81.0 82.0 03:57:10 INFO - 2015-11-13 03:57:10,345 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,345 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:107.00 Median:108.00 stddev:2.94 (2.7%) stddev-sans-first:2.18 03:57:10 INFO - 2015-11-13 03:57:10,345 DEBUG : BROWSER_OUTPUT: Values: 101.0 105.0 109.0 111.0 110.0 109.0 107.0 105.0 106.0 107.0 03:57:10 INFO - 2015-11-13 03:57:10,345 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,346 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:161.50 Median:160.50 stddev:9.94 (6.2%) stddev-sans-first:9.93 03:57:10 INFO - 2015-11-13 03:57:10,346 DEBUG : BROWSER_OUTPUT: Values: 152.0 160.0 161.0 160.0 178.0 151.0 154.0 158.0 161.0 180.0 03:57:10 INFO - 2015-11-13 03:57:10,346 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,346 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.00 Median:194.50 stddev:4.55 (2.3%) stddev-sans-first:4.81 03:57:10 INFO - 2015-11-13 03:57:10,347 DEBUG : BROWSER_OUTPUT: Values: 192.0 196.0 196.0 194.0 194.0 193.0 195.0 197.0 192.0 181.0 03:57:10 INFO - 2015-11-13 03:57:10,348 DEBUG : BROWSER_OUTPUT: 03:57:10 INFO - 2015-11-13 03:57:10,348 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:88.40 Median:89.50 stddev:3.44 (3.8%) stddev-sans-first:1.87 03:57:10 INFO - 2015-11-13 03:57:10,348 DEBUG : BROWSER_OUTPUT: Values: 80.0 86.0 92.0 88.0 88.0 90.0 91.0 91.0 89.0 89.0 03:57:10 INFO - 2015-11-13 03:57:10,348 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:57:10 INFO - 2015-11-13 03:57:10,348 DEBUG : BROWSER_OUTPUT: 03:57:11 INFO - 2015-11-13 03:57:11,078 INFO : Browser exited with error code: 0 03:57:11 INFO - 2015-11-13 03:57:11,133 INFO : Completed test kraken (00:01:03) 03:57:11 INFO - 2015-11-13 03:57:11,134 INFO : Starting test v8_7 03:57:11 INFO - 2015-11-13 03:57:11,134 DEBUG : operating with platform_type : mac_ 03:57:11 INFO - 2015-11-13 03:57:11,134 INFO : Initialising browser for v8_7 test... 03:57:11 INFO - 2015-11-13 03:57:11,149 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/tmp5e14Ax/profile http://localhost:51222/getInfo.html 03:57:14 INFO - 2015-11-13 03:57:14,405 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:57:14 INFO - 2015-11-13 03:57:14,405 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:57:14 INFO - 2015-11-13 03:57:14,405 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 03:57:14 INFO - 2015-11-13 03:57:14,406 DEBUG : BROWSER_OUTPUT: __metrics 03:57:15 INFO - 2015-11-13 03:57:15,108 INFO : Browser initialized. 03:57:15 INFO - 2015-11-13 03:57:15,108 INFO : Running cycle 1/1 for v8_7 test... 03:57:15 INFO - 2015-11-13 03:57:15,108 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/T/tmp5e14Ax/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:57:27 INFO - 2015-11-13 03:57:27,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 242323456 03:57:27 INFO - 2015-11-13 03:57:27,284 DEBUG : BROWSER_OUTPUT: 03:57:49 INFO - 2015-11-13 03:57:49,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51222/tests/v8_7/run.html (next: http://localhost:51222/tests/v8_7/run.html) 03:57:50 INFO - 2015-11-13 03:57:50,223 DEBUG : BROWSER_OUTPUT: RSS: Main: 260833280 03:57:50 INFO - 2015-11-13 03:57:50,224 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,224 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:57:50 INFO - 2015-11-13 03:57:50,224 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:57:50 INFO - 2015-11-13 03:57:50,224 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:57:50 INFO - 2015-11-13 03:57:50,224 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:57:50 INFO - 2015-11-13 03:57:50,224 DEBUG : BROWSER_OUTPUT: |0;Richards;884.9557522123894 03:57:50 INFO - 2015-11-13 03:57:50,224 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;233.590282644242 03:57:50 INFO - 2015-11-13 03:57:50,224 DEBUG : BROWSER_OUTPUT: |2;Encrypt;394.16633819471815 03:57:50 INFO - 2015-11-13 03:57:50,225 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6738.255033557047 03:57:50 INFO - 2015-11-13 03:57:50,225 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1367.9890560875513 03:57:50 INFO - 2015-11-13 03:57:50,225 DEBUG : BROWSER_OUTPUT: |5;Earley;932.8358208955224 03:57:50 INFO - 2015-11-13 03:57:50,225 DEBUG : BROWSER_OUTPUT: |6;Boyer;15348.484848484848 03:57:50 INFO - 2015-11-13 03:57:50,226 DEBUG : BROWSER_OUTPUT: |7;RegExp;35275.862068965514 03:57:50 INFO - 2015-11-13 03:57:50,226 DEBUG : BROWSER_OUTPUT: |8;Splay;765.6967840735069 03:57:50 INFO - 2015-11-13 03:57:50,226 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6790.540540540541 03:57:50 INFO - 2015-11-13 03:57:50,227 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:57:50 INFO - 2015-11-13 03:57:50,228 DEBUG : BROWSER_OUTPUT: __startTimestamp1447415870223__endTimestamp 03:57:50 INFO - 2015-11-13 03:57:50,228 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,228 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:57:50 INFO - 2015-11-13 03:57:50,228 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:57:50 INFO - 2015-11-13 03:57:50,228 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,228 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:884.96 Median:884.96 stddev:0.00 (0.0%) 03:57:50 INFO - 2015-11-13 03:57:50,228 DEBUG : BROWSER_OUTPUT: Values: 885.0 03:57:50 INFO - 2015-11-13 03:57:50,228 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,228 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:233.59 Median:233.59 stddev:0.00 (0.0%) 03:57:50 INFO - 2015-11-13 03:57:50,229 DEBUG : BROWSER_OUTPUT: Values: 233.6 03:57:50 INFO - 2015-11-13 03:57:50,229 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,229 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:394.17 Median:394.17 stddev:0.00 (0.0%) 03:57:50 INFO - 2015-11-13 03:57:50,229 DEBUG : BROWSER_OUTPUT: Values: 394.2 03:57:50 INFO - 2015-11-13 03:57:50,229 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,229 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6738.26 Median:6738.26 stddev:0.00 (0.0%) 03:57:50 INFO - 2015-11-13 03:57:50,229 DEBUG : BROWSER_OUTPUT: Values: 6738.3 03:57:50 INFO - 2015-11-13 03:57:50,229 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,229 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1367.99 Median:1367.99 stddev:0.00 (0.0%) 03:57:50 INFO - 2015-11-13 03:57:50,229 DEBUG : BROWSER_OUTPUT: Values: 1368.0 03:57:50 INFO - 2015-11-13 03:57:50,230 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,230 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:932.84 Median:932.84 stddev:0.00 (0.0%) 03:57:50 INFO - 2015-11-13 03:57:50,230 DEBUG : BROWSER_OUTPUT: Values: 932.8 03:57:50 INFO - 2015-11-13 03:57:50,230 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,230 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15348.48 Median:15348.48 stddev:0.00 (0.0%) 03:57:50 INFO - 2015-11-13 03:57:50,230 DEBUG : BROWSER_OUTPUT: Values: 15348.5 03:57:50 INFO - 2015-11-13 03:57:50,230 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,231 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35275.86 Median:35275.86 stddev:0.00 (0.0%) 03:57:50 INFO - 2015-11-13 03:57:50,231 DEBUG : BROWSER_OUTPUT: Values: 35275.9 03:57:50 INFO - 2015-11-13 03:57:50,231 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,231 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:765.70 Median:765.70 stddev:0.00 (0.0%) 03:57:50 INFO - 2015-11-13 03:57:50,231 DEBUG : BROWSER_OUTPUT: Values: 765.7 03:57:50 INFO - 2015-11-13 03:57:50,231 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,231 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6790.54 Median:6790.54 stddev:0.00 (0.0%) 03:57:50 INFO - 2015-11-13 03:57:50,231 DEBUG : BROWSER_OUTPUT: Values: 6790.5 03:57:50 INFO - 2015-11-13 03:57:50,231 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:57:50 INFO - 2015-11-13 03:57:50,232 DEBUG : BROWSER_OUTPUT: 03:57:50 INFO - 2015-11-13 03:57:50,930 INFO : Browser exited with error code: 0 03:57:50 INFO - 2015-11-13 03:57:50,954 INFO : Completed test v8_7 (00:00:39) 03:57:51 INFO - 2015-11-13 03:57:51,137 INFO : Completed test suite (00:20:16) 03:57:51 INFO - 2015-11-13 03:57:51,137 DEBUG : Working with test: dromaeo_css 03:57:51 INFO - 2015-11-13 03:57:51,137 DEBUG : Generating results file: dromaeo_css 03:57:51 INFO - 2015-11-13 03:57:51,138 DEBUG : Working with test: kraken 03:57:51 INFO - 2015-11-13 03:57:51,138 DEBUG : Generating results file: kraken 03:57:51 INFO - 2015-11-13 03:57:51,139 INFO : javascript benchmark 03:57:51 INFO - 2015-11-13 03:57:51,139 DEBUG : Working with test: v8_7 03:57:51 INFO - 2015-11-13 03:57:51,139 DEBUG : Generating results file: v8_7 03:57:51 INFO - 2015-11-13 03:57:51,139 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:57:51 INFO - 2015-11-13 03:57:51,199 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 03:57:51 INFO - 2015-11-13 03:57:51,199 DEBUG : process_Request line: dromaeo_css 5669.41 graph.html#tests=[[72,64,57]] 03:57:51 INFO - 2015-11-13 03:57:51,199 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:57:51 INFO - 2015-11-13 03:57:51,230 DEBUG : process_Request line: kraken 1872.70 graph.html#tests=[[232,64,57]] 03:57:51 INFO - 2015-11-13 03:57:51,230 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:57:51 INFO - 2015-11-13 03:57:51,259 DEBUG : process_Request line: v8_7 14155.87 graph.html#tests=[[230,64,57]] 03:57:51 INFO - 2015-11-13 03:57:51,260 INFO : javascript benchmark 03:57:51 INFO - 2015-11-13 03:57:51,262 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [275.79315513364975, 278.18769193953653, 278.83409371423994, 284.9031329348021, 289.995650065249, 12201.877981220185, 14331.785023224647, 14614.634634134152, 14840.703185936274, 14848.628784280385, 14183.574492765209, 14398.49605263816, 14509.201993890332, 14695.706085878275, 14763.335649895753, 4385.0, 4402.1195760847795, 4527.909441811162, 4573.176828170945, 4588.334691469735, 4442.911141777163, 4478.373027776114, 4485.282354823229, 4490.663200259977, 4525.637948964091, 3173.1591128351006, 3295.5715756951563, 4424.734515929038, 4452.777361131946, 4743.644226682995, 4887.095887260833, 4909.257213689142, 4914.8771280718265, 4919.188333924916, 4951.653384263103, 4114.629683328515, 4234.25900467417, 4238.0888109056705, 4267.338562522814, 4321.286987647034, 17335.65328693419, 17373.13134343278, 17559.20983555743, 17950.551236219068, 17957.461276161604, 1544.5057581573901, 1622.448367555037, 1637.8198398176191, 1715.4939292908498, 1786.0533917023868, 10851.0, 10910.727231819188, 10932.617358392497, 11275.097992160689, 11694.415279236004, 1347.124369160054, 1382.3364784903201, 1387.029079644253, 1390.2978995607255, 1433.362153841541, 47142.29286560704, 49518.257226141635, 49628.503714962746, 49686.25470617944, 50101.24848127244, 7794.3764498839955, 7901.604919754104, 8156.673733050611, 8241.217084376975, 8245.299149572234, 9938.503074846229, 9966.302358834811, 10005.849912251322, 10027.29808913369, 10106.039926206999, 6418.807435776934, 6458.095866578683, 6537.869242615121, 6563.3764792344655, 6599.439047680905, 6439.645819479973, 6475.7085931133215, 6531.575447595891, 6556.311587283267, 6604.405603495708, 4743.0988112258565, 4756.571908528249, 4804.159272127434, 4806.615470762331, 4883.267509873547, 1405.4378248700398, 1452.1142103316968, 1457.9125252484885, 1462.4150339864138, 1462.8902832287622, 318.7641145552275, 322.35207233460915, 325.34443097159243, 765.7779244019283, 798.4690181029666, 8332.458390204618, 8481.915180848237, 8748.8687669685, 8767.868481972775, 8789.736307910773, 339.7927264368733, 340.5011657921157, 345.3059350705051, 349.11499349149784, 351.3096764857068, 4587.931181032287, 4636.559526844944, 4639.489656137822, 4644.767761611906, 4758.262469317261, 411670.0, 417050.0, 426415.0, 436433.0, 440854.0, 56924.71537642368, 57787.0, 57969.71015144897, 58044.0, 60214.69892650509, 372.5641000029971, 373.9383001804726, 374.8350725680746, 378.143504961263, 378.93368660484856, 8177.264046235868, 8185.795355115932, 8192.631331589973, 8230.547319897463, 8417.0, 26744.19767406981, 26948.191554253404, 27483.587746184225, 27566.5865012029, 27765.72234277712, 38853.611463885, 38860.41709374305, 38865.44538218439, 39102.6089739099, 39874.40188397234, 4910.410750709938, 5021.899562008813, 5176.9741151294, 5246.501582349671, 5274.947250527445, 9542.618295268388, 9570.090841370058, 9679.177269932135, 9803.411795292306, 9928.652497162564, 7204.3155900189395, 8169.836603267782, 8363.0, 8494.532800695773, 8584.570771461276, 6876.449884009367, 8024.478408903403, 8046.436749427484, 8344.16558344185, 8580.485170889766, 8207.112364156159, 8343.666253349798, 8559.058503564478, 8593.226609605166, 8649.956750216208, 4886.828960986349, 5175.094358487175, 5181.948180518298, 5205.505476979681, 5230.03244399772, 8174.141715119827, 8311.584420778816, 8339.666413343399, 8362.12197719255, 8516.276116529916], "dojo.html": [2618.9345266368346, 2626.553485907396, 2628.5531459651856, 2694.1782756259345, 2720.823146495479, 4407.889802754933, 4493.3484644726495, 4554.157480866038, 4567.474740404846, 4587.701799383038, 4372.0, 4414.735115893049, 4441.333799930012, 4569.428821397325, 4573.474050484196, 4111.60939710727, 4191.098913733546, 4237.258479766044, 4281.122369914176, 4333.60997510224, 4185.330347144458, 4220.556841531626, 4301.462317210348, 4312.331588603755, 4362.018545827195, 4078.877633670995, 4107.609777071173, 4190.790460476964, 4220.113776107021, 4264.445622069111, 4190.07818279981, 4197.538270790211, 4200.474940632421, 4219.38818871265, 4227.957720422787, 4173.64524015459, 4177.895552611209, 4184.91630167398, 4209.536950935395, 4284.378765079077, 4107.95247211959, 4284.978575107136, 4334.544872788375, 4368.191884501346, 4415.227335216325, 4721.480637129913, 4748.406449193851, 4766.475687674353, 4785.282207668843, 4827.25177597473, 4792.664513484057, 4793.400824896888, 4811.59101476375, 4832.1543729847135, 4877.609791216694, 4271.67962402821, 4315.546867578891, 4370.781460926941, 4455.754933478657, 4474.977625111918, 4904.901901961941, 4934.407871055496, 4965.776540055706, 4969.055879382906, 4983.5763960063805, 4450.866474005785, 4685.20351540239, 4692.601128904082, 4696.178168820511, 4726.338312636233, 4608.147492713859, 4688.835890743876, 4791.065742180242, 4798.808047678054, 4874.2444921037295, 4656.301554766812, 4681.391419115494, 4713.9764301178275, 4720.787564559603, 4721.362616046858, 4615.26155815068, 4679.0, 4716.339712440261, 4729.527047295243, 4753.857384278477, 3628.818559072036, 3683.834227459717, 3729.9067523312133, 3751.174741556853, 3767.56672982605, 3292.884749033772, 3293.9176520587175, 3295.5715756951445, 3325.285063711314, 3415.8975230743117, 4227.260229459832, 4284.957150428519, 4339.305711086211, 4378.474583050054, 4468.106378724203, 4794.856154315376, 4795.592374648124, 4820.421549414093, 4820.879478013007, 4903.509649035139, 4399.956000440018, 4400.75795831226, 4441.222786012435, 4488.528704486047, 4504.887377815516, 4025.6980726445636, 4129.215449064668, 4175.874723758292, 4184.7070705050355, 4240.236757383639, 4899.118158731462, 4911.484294149134, 4937.753112344297, 4968.180250258667, 4994.3507344045765, 4801.303810947463, 4847.321375007572, 4848.5636292733825, 4874.195757700081, 4921.680090794087, 4719.0, 4793.9280910785665, 4850.1269771441475, 4905.533974272438, 4924.261360795909, 4740.644451666208, 4749.881252968566, 4770.522947705202, 4789.688670236424, 4792.2092854678585, 4583.991521865184, 4833.419989601271, 4843.709377437365, 4852.393450818648, 4906.533879281463, 4317.827286908614, 4562.4068871047875, 4563.794629241625, 4639.698419602715, 4670.929936050894, 4682.812687492462, 4692.601128904082, 4704.482506924167, 4728.290756386569, 4754.881127971828, 4378.387025816452, 4415.0, 4557.863264102082, 4594.081183763194, 4622.583967442946, 4494.5505449454795, 4575.837782064505, 4609.492955774929, 4614.584687378152, 4622.2835460503675, 4568.428946381702, 4592.311153327028, 4599.379083823775, 4637.072585482984, 4646.558576935186], "mootools.html": [1454.9960527236199, 1501.534524297468, 1517.4764706176372, 1530.204293767241, 1570.1835045776193, 5920.763169473226, 6112.358202388741, 6560.868782624345, 6854.794356169316, 6856.314368563148, 6305.3064162942155, 6420.967895160517, 6543.24752653445, 6553.77061802837, 6558.442532384753, 1779.5373202967257, 1789.6510180514804, 1795.9461216163536, 1808.3309175605045, 1809.9185536650882, 1805.0523475175507, 1818.672638924993, 1832.2854086906118, 1834.0371305064814, 1851.6389304085708, 1797.2002458905793, 1821.6356728654255, 1822.4168266154836, 1829.277435413011, 1845.2342277954633, 1804.242218268324, 1805.0794095011508, 1843.0876716025587, 1866.990665046666, 1867.7665291838384, 1828.7714035745532, 1832.743415921772, 1843.5759775251768, 1843.6128413033146, 1863.0777765006274, 6592.86814263712, 6692.163479565054, 6726.192856857159, 6745.831354216135, 6758.0, 3795.8291876865605, 3891.6886649068006, 3896.376579747227, 3929.5873933236885, 3942.3298039333094, 2204.9889750551147, 2231.3752149398033, 2363.550925324183, 2425.333033415807, 2439.499902519997, 777.996110019452, 795.7533164718956, 803.3292201012162, 806.7095845495617, 810.0, 8548.187922147386, 8559.101294364064, 8586.570671466465, 8628.007779105421, 8668.393212475192, 3396.5924089109467, 3433.9656603434146, 3468.4450487921813, 3484.6341134181052, 3524.823758812049, 7687.308142267223, 7692.307692307719, 7732.342750866239, 7757.340626046736, 7772.106207786177, 3940.645341919241, 3942.250972315251, 3946.2699400610977, 3959.8812035638975, 4001.4998125234347, 3598.5321908151773, 3613.6567026132475, 3616.710663146942, 3619.619939906272, 3641.635836416337, 3044.497657886468, 3056.9847150764103, 3090.5518699788404, 3098.5816914716675, 3112.50199968004, 975.5512464266517, 978.5694294510392, 981.563204374061, 981.6269817469316, 989.317371013998, 846.0820010288905, 1099.14816017587, 1099.8405231241425, 1136.3977092141179, 1137.3573930729112, 6172.444479996821, 6209.65846878417, 6236.345183755731, 6241.906371404432, 6256.280527739368, 342.52218155673194, 347.6731872040274, 353.0696614421019, 354.59044803252283, 356.3638904555356, 4789.784459699322, 4848.0788650157065, 4851.854444366674, 4862.95137048625, 4868.9269660955115, 7285.562866228043, 7326.3040011198855, 7568.772936811794, 7656.425768067417, 7950.0857401398425, 7795.844083118419, 7799.883001754978, 7820.061592608809, 7826.608669566499, 7850.725224617111, 6071.362506936796, 6143.692815359214, 6249.500039996789, 6259.937400626027, 6286.277078135981, 5987.7604895805425, 6010.609310394811, 6011.879762404815, 6105.145279660762, 6126.693665316806, 6559.8032059038305, 6791.524593278423, 6805.6937437816405, 7017.649117544001, 7083.256258092826, 6960.269171736894, 7236.710531578678, 7269.3094156055095, 7272.200057993722, 7315.926840731738, 5875.148103525051, 5883.705814709162, 5889.5582831286965, 5892.1161825726485, 5941.673207973603, 6239.251289845248, 6248.9062664059165, 6296.559240853279, 6354.205724284465, 6416.807495775134, 5603.355614104267, 5862.882742345215, 5933.465988061095, 6028.3971602839365, 6034.125051867367, 5726.398728133652, 5755.8561035974435, 5758.769649214152, 5804.361520232686, 5923.526117910643, 5860.120981852586, 5919.852003699942, 5930.7627694893445, 5956.344802071682, 6005.909911351246, 5309.150535914235, 5355.973220133875, 5375.059364611256, 5391.056565101013, 5396.757145928521, 5402.972985135049, 5435.429279925551, 5437.728113594384, 5448.536874365724, 5470.261514695465], "ext.html": [457.4876138724629, 476.7044432451879, 480.0495019860676, 485.0154187000388, 500.4420071620145, 32342.67657323426, 33035.66964330356, 33190.66809331906, 33408.33183336332, 33858.0, 34996.65003349966, 35170.12074698134, 35237.119072023146, 35388.82305588475, 35773.642263577356, 7725.575093369863, 7835.569043702594, 7927.762167134995, 7932.762017139495, 8025.598720064003, 7725.304722574967, 7779.066512018566, 7833.686652533892, 7898.328642065431, 7898.80252993674, 7767.495112817649, 7779.844403111934, 7803.3367163791145, 7825.882611760828, 7854.567998760066, 7717.49836260644, 7802.804929876742, 7812.023497062895, 7858.567778772165, 7941.5632140232265, 7650.120236172856, 7723.806904827368, 7730.690772369098, 7783.805404864867, 7838.608069596497, 33028.33943321144, 33435.16412089693, 33465.49801752975, 33477.33045339104, 33486.33027339439, 2415.130553000918, 2449.2529778417575, 2552.5660637691453, 2653.40298432853, 2823.378856651554, 22645.433864153365, 23023.1941882035, 23227.30318090443, 23231.651525227135, 24179.0, 1979.2281010405952, 2008.2970960163973, 2032.0, 2034.0643304079993, 2057.177129148353, 201300.0, 205984.0, 205995.97002015045, 206204.0, 206302.0, 47204.5279547207, 47759.761201193774, 47885.0, 48369.0, 48499.515004850204, 60033.399666002784, 61212.0, 61254.38745612576, 61314.69342653258, 61699.0, 13648.522301719393, 14046.297685115704, 14104.224267665377, 14128.576142715528, 14137.222452765196, 10594.629187978384, 10740.0, 10745.677629671123, 10748.0, 10775.78448431027, 17107.572310692085, 17200.053997030034, 17231.56921076958, 17245.137743112795, 17289.3948711797, 7352.77941661751, 7571.697132114764, 7617.809554761176, 7627.580483073484, 7640.73257435987, 783.1502819440857, 801.9639116239666, 872.6509396241554, 949.2975198353307, 962.6245764151986, 22122.0, 22308.888455557943, 22576.51658317584, 22576.66135007976, 22812.885935570215, 850.4259624753266, 952.5999080386255, 992.2359782967219, 1010.1817527802357, 1014.0366651680932, 11822.467988940518, 11966.64100076999, 11997.400129993466, 12031.578894738643, 12045.795420457884, 262965.0, 263160.0, 268098.0, 268647.0, 269440.0, 45169.77415112904, 45529.54470455319, 45662.315065274044, 45765.31352029722, 45796.0, 1149.2989276541302, 1167.2471256039807, 1172.6013155527162, 1184.0705046538599, 1196.21050106929, 23120.84395780238, 23453.06187752471, 23489.765102348756, 23528.529429411657, 23693.0, 39531.80234098811, 39690.2061958765, 40299.395509067974, 40378.59621403748, 40409.59590404058, 248532.0, 248999.0, 250647.0, 250653.0, 250683.0, 27187.72812271852, 34202.14494637654, 35266.82366588253, 36056.63943360533, 36083.309169807755, 35570.822145889106, 35897.820510897276, 35924.0, 36392.27215455729, 37118.62881371152, 29960.250993724458, 30384.544231836982, 30682.84658576693, 30771.69228307688, 31108.377832442773, 29479.85260073686, 29701.257468563457, 29801.25496862596, 29837.0, 30261.848690756404, 30136.095917122522, 30385.544216837206, 30459.192600924885, 30743.53884691687, 31129.68870311268, 25339.746602534477, 26427.339316517242, 26550.0, 27052.32369190786, 27072.187834365002, 19346.0, 19498.122584483448, 19605.70591441158, 19645.11596978168, 19844.801551984296], "prototype.html": [254.63587070489206, 256.95117927593753, 266.0714107763904, 266.3022880054258, 267.09987342655256, 5162.096633089203, 5205.505476979685, 5319.92020119698, 5331.120365139747, 5360.463953604638, 5103.591712662987, 5275.709835959021, 5294.735263236842, 5322.0154271459805, 5357.08929481988, 4130.277201489742, 4150.190712810995, 4175.290200665879, 4209.831606735727, 4214.431051807997, 4142.523609784883, 4147.1705658868195, 4156.667466602665, 4181.414601955728, 4249.405083288342, 3895.0, 4107.527634322047, 4146.1914926589325, 4179.185058913513, 4204.789760511978, 4052.4326594276827, 4058.3100872851687, 4071.531773846001, 4116.320807066831, 4148.564400737924, 3446.293509830479, 3458.8270586470576, 3482.2513159670793, 3505.0, 3519.296140771856, 4935.80256789728, 5035.798568057273, 5121.513456221653, 5141.6143789215585, 5180.248863914711, 4459.710118842265, 4507.706999045052, 4540.568645978627, 4548.840790572347, 4596.241620132708, 5594.104943209108, 5597.188407680864, 5645.689487078209, 5661.0, 5677.176809362661, 3692.132348898007, 3700.40793473043, 3711.2763011212824, 3724.7578907370935, 3742.1954279829965, 5693.28833895763, 5801.361850196475, 5830.4169583041785, 5920.851978700523, 5943.494802941756, 3753.230587729509, 3763.473113764075, 3766.3597188478025, 3792.829322680486, 3813.771173729585, 3803.372443546784, 3804.1060350817534, 3809.9047523811573, 3822.617738226211, 3877.0501227199516, 4460.152571011562, 4473.821047158077, 4481.395011673448, 4536.092781443725, 4559.680822342404, 5368.436314187033, 5406.540444062299, 5500.532454741392, 5536.141898005815, 5655.886882262332, 1318.228836130855, 1339.598120563827, 1341.2891167681144, 1348.3864841497095, 1366.125679565079, 839.8446287436843, 861.9353548483764, 864.7362554420962, 868.405142477405, 889.4485419040236, 5291.126964050965, 5303.231031500411, 5371.248025276464, 5391.110466772939, 5402.6758394496455, 5799.0, 5805.419458054161, 5816.098504731774, 5899.852503687356, 5906.7637294508595, 5288.153895376721, 5298.761555730001, 5357.383900851452, 5386.13821788512, 5401.405845357008, 3022.3653032862903, 3105.223694076481, 3140.262038420969, 3189.6012998375204, 3194.2653189766484, 5981.700914954235, 5999.130126131774, 6025.879482410327, 6041.909371359433, 6044.486218671374, 5952.166696662471, 5958.880822383528, 5974.103884417372, 6052.788152414644, 6073.817785466443, 5856.94143058581, 5955.910661340084, 5961.642301461839, 6041.24484439445, 6082.057281121433, 5811.4479124483105, 5824.970875145597, 5883.0, 5899.262592175978, 5945.078512830518, 5633.943660563342, 5709.543236540983, 5738.081906894877, 5756.42435756421, 5785.942140578709, 5970.253718285215, 5989.221401217814, 6028.3971602839365, 6073.423024812636, 6099.8780024398375, 3700.2414505025868, 3749.9250015000093, 3775.0, 3781.6029316921326, 3804.20111776519, 5728.083506638918, 5774.220480235114, 5780.2485676863425, 5815.0, 5884.0, 5569.944300556943, 5595.384507704231, 5611.438856114356, 5669.603127781016, 5703.372629010889, 5587.245721827664, 5592.077307244259, 5626.0, 5630.662160270397, 5686.9715651421475, 5281.973590132025, 5491.148871924858, 5492.231087647812, 5496.422875598005, 5537.584681148849, 5604.495595396434, 5612.7193640317, 5635.6618602883955, 5662.2639056922335, 5685.658860468385, 5468.699221542854, 5474.479924407175, 5481.177823326533, 5572.219889215432, 5577.6653400796085], "yui.html": [619.6096459230685, 622.6855438003807, 634.629658226524, 648.7956293767465, 650.2327253840468, 11178.21752477326, 11392.430378481075, 11900.7619847603, 11947.64157075287, 12131.636050918487, 10944.890551094486, 11029.889701103006, 11084.390358530298, 11266.549338026489, 11288.604898828542, 583.1748076471787, 588.4556784973903, 746.5669911451345, 755.2296657409453, 775.244136966456, 750.9586972716498, 753.1752730759837, 764.598585742484, 766.9309762121408, 781.9726309579166, 788.6175205025557, 798.2616080125889, 800.2597597222575, 801.3749275565068, 801.8556659801234, 794.1978601612356, 794.9403794715362, 797.7965618767236, 800.2277801921174, 800.671724592917, 588.8881112588595, 589.3576002157625, 589.6226415094343, 595.8808238352347, 598.1715324275866, 10374.481275936172, 10490.842637360445, 10594.099501542378, 10624.043836054714, 10653.25427220095, 9425.104615061558, 9586.328956973015, 9981.70054898347, 10120.848187277197, 10218.080372766412, 7666.348360389374, 7821.100573434071, 8064.395170362246, 8070.192980701941, 8474.74575762728, 2781.5549512078173, 2791.064993227251, 2827.6889542150348, 2829.6604407471027, 2840.076974983139, 40865.387019194735, 40973.97565060868, 41068.794656026825, 41184.1763164738, 41533.376999344735, 7651.464397492122, 7837.2162783722315, 7901.130875603679, 8075.636596353178, 8092.959535202404, 16250.349986000663, 16304.673906521803, 16480.0935948524, 16486.0, 16531.173441327886, 5240.737963101829, 5268.868278293074, 5448.182772584065, 5497.47773961473, 6061.454469097803, 3094.5512900629283, 3104.9534256986162, 3143.1042152986747, 3178.523221516745, 3241.4813629819587, 2308.9653655195184, 2342.7071616047992, 2344.5896968030524, 2363.2437619961447, 2365.6451532269953, 338.1546134663342, 338.52606351108153, 342.5683638615363, 345.2335814491824, 348.6548317165987, 418.48317328099773, 470.88698712309485, 474.70093840880713, 512.4439982618826, 530.3688610553506, 5882.705864706748, 6354.459870910932, 6390.447004539807, 6390.584612000205, 6604.966975165094, 403.50570551074696, 446.533372625607, 485.74498388345694, 509.54395815744704, 532.4568939681503, 2914.4753944290233, 3119.547665588477, 3149.4645910195322, 3176.904692859218, 3201.183698156955, 48916.510834891196, 50057.49942500601, 50430.243546346836, 50828.745856270485, 50898.74550627223, 44219.55780442154, 44387.55612443834, 44761.32858007133, 44780.77609611996, 45462.54537454583, 39917.80041099834, 40105.39841902374, 40252.79873600672, 40473.79763101166, 40529.79735101364, 6335.429811317003, 6404.295527491879, 6426.0, 6447.806565803034, 6553.770618028346, 29148.854255728587, 29302.0, 29806.70193298039, 29973.550396744504, 30214.093577192718, 37620.0, 38059.80970095243, 38293.4255986166, 38645.6135438642, 38964.41553376645, 6541.70562324687, 6614.404703576702, 6623.205215374186, 6700.430463410665, 6982.441404687511, 9401.294902882448, 9423.717288481357, 9451.385659932082, 9474.85787713171, 9510.38182518134, 8876.156765107304, 8937.329700272636, 8939.195472407515, 8942.239909607757, 8956.462612243286, 8784.95607521984, 8871.556422178735, 8885.200331970154, 8911.15344042315, 8929.196372326522, 8811.0, 8857.911420885966, 8875.644974200959, 8883.0, 8895.955520222358, 7445.739399121005, 7531.0, 8021.382374500665, 8081.595920204084, 8101.098835204852, 7534.773956781305, 7574.242575742602, 7645.935447841162, 7811.414143939341, 7823.647935842787]}, "summary": {"lowerIsBetter": false, "suite": 5669.404374763119, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6209.285733691867, "unit": "ms", "value": 6209.285733691867}, "dojo.html": {"lowerIsBetter": false, "filtered": 4417.435530516384, "unit": "ms", "value": 4417.435530516384}, "mootools.html": {"lowerIsBetter": false, "filtered": 3646.826810150202, "unit": "ms", "value": 3646.826810150202}, "ext.html": {"lowerIsBetter": false, "filtered": 15670.345689377831, "unit": "ms", "value": 15670.345689377831}, "prototype.html": {"lowerIsBetter": false, "filtered": 4182.025830799001, "unit": "ms", "value": 4182.025830799001}, "yui.html": {"lowerIsBetter": false, "filtered": 5065.091536800966, "unit": "ms", "value": 5065.091536800966}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0100.e"}, "testrun": {"date": 1447414655, "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": "20151113013632", "branch": "Fx-Team", "revision": "d6d640c4b8c2097f3a780f6420c197dc698a8183"}}, {"talos_counters": {}, "results": {"audio-dft": [200.0, 202.0, 213.0, 204.0, 198.0, 193.0, 202.0, 203.0, 205.0, 203.0], "ai-astar": [130.0, 125.0, 135.0, 138.0, 134.0, 144.0, 136.0, 134.0, 136.0, 135.0], "imaging-gaussian-blur": [149.0, 142.0, 142.0, 149.0, 149.0, 157.0, 150.0, 149.0, 148.0, 143.0], "audio-beat-detection": [183.0, 162.0, 190.0, 204.0, 157.0, 182.0, 178.0, 157.0, 197.0, 169.0], "json-stringify-tinderbox": [74.0, 78.0, 81.0, 83.0, 82.0, 83.0, 81.0, 83.0, 81.0, 82.0], "stanford-crypto-pbkdf2": [192.0, 196.0, 196.0, 194.0, 194.0, 193.0, 195.0, 197.0, 192.0, 181.0], "json-parse-financial": [71.0, 73.0, 78.0, 77.0, 78.0, 78.0, 77.0, 84.0, 80.0, 81.0], "stanford-crypto-sha256-iterative": [80.0, 86.0, 92.0, 88.0, 88.0, 90.0, 91.0, 91.0, 89.0, 89.0], "audio-fft": [81.0, 88.0, 100.0, 148.0, 85.0, 88.0, 90.0, 86.0, 122.0, 80.0], "imaging-darkroom": [157.0, 157.0, 164.0, 158.0, 157.0, 156.0, 156.0, 157.0, 157.0, 156.0], "stanford-crypto-ccm": [152.0, 160.0, 161.0, 160.0, 178.0, 151.0, 154.0, 158.0, 161.0, 180.0], "audio-oscillator": [109.0, 109.0, 150.0, 108.0, 108.0, 109.0, 152.0, 114.0, 108.0, 152.0], "stanford-crypto-aes": [101.0, 105.0, 109.0, 111.0, 110.0, 109.0, 107.0, 105.0, 106.0, 107.0], "imaging-desaturate": [118.0, 134.0, 129.0, 137.0, 118.0, 120.0, 123.0, 123.0, 124.0, 128.0]}, "summary": {"lowerIsBetter": true, "suite": 1872.7000000000003, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 96.8, "unit": "ms", "value": 96.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 193.0, "unit": "ms", "value": 193.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 177.9, "unit": "ms", "value": 177.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 161.5, "unit": "ms", "value": 161.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 157.5, "unit": "ms", "value": 157.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 77.7, "unit": "ms", "value": 77.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 121.9, "unit": "ms", "value": 121.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 134.7, "unit": "ms", "value": 134.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 202.3, "unit": "ms", "value": 202.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 88.4, "unit": "ms", "value": 88.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 80.8, "unit": "ms", "value": 80.8}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 147.8, "unit": "ms", "value": 147.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 107.0, "unit": "ms", "value": 107.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 125.4, "unit": "ms", "value": 125.4}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0100.e"}, "testrun": {"date": 1447414655, "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": "20151113013632", "branch": "Fx-Team", "revision": "d6d640c4b8c2097f3a780f6420c197dc698a8183"}}, {"talos_counters": {}, "results": {"DeltaBlue": [233.590282644242], "Encrypt": [394.16633819471815], "NavierStokes": [6790.540540540541], "Decrypt": [6738.255033557047], "Splay": [765.6967840735069], "Richards": [884.9557522123894], "RegExp": [35275.862068965514], "Earley": [932.8358208955224], "Boyer": [15348.484848484848], "RayTrace": [1367.9890560875513]}, "summary": {"lowerIsBetter": false, "suite": 14155.865050823326, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 283.0511580000001, "unit": "score", "value": 283.0511580000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 675.301197, "unit": "score", "value": 675.301197}, "NavierStokes": {"lowerIsBetter": false, "filtered": 218.5393034825869, "unit": "score", "value": 218.5393034825869}, "Decrypt": {"lowerIsBetter": false, "filtered": 39.502957171314755, "unit": "score", "value": 39.502957171314755}, "Splay": {"lowerIsBetter": false, "filtered": 106.42724599999998, "unit": "score", "value": 106.42724599999998}, "RegExp": {"lowerIsBetter": false, "filtered": 25.824599217986318, "unit": "score", "value": 25.824599217986318}, "Richards": {"lowerIsBetter": false, "filtered": 39.89126000000002, "unit": "score", "value": 39.89126000000002}, "Earley": {"lowerIsBetter": false, "filtered": 714.4483359999998, "unit": "score", "value": 714.4483359999998}, "Boyer": {"lowerIsBetter": false, "filtered": 43.422071076011875, "unit": "score", "value": 43.422071076011875}, "RayTrace": {"lowerIsBetter": false, "filtered": 540.9319589999998, "unit": "score", "value": 540.9319589999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0100.e"}, "testrun": {"date": 1447414655, "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": "20151113013632", "branch": "Fx-Team", "revision": "d6d640c4b8c2097f3a780f6420c197dc698a8183"}}] 03:57:51 INFO - RETURN: dromaeo_css: 5669.41 03:57:51 INFO - RETURN: kraken: 1872.70 03:57:51 INFO - RETURN: v8_7: 14155.87 03:57:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "14155.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1872.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5669.41"}}} 03:57:51 INFO - Return code: 0 03:57:51 INFO - # TBPL SUCCESS # 03:57:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:57:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:57:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:57:51 INFO - 2015-11-13 03:57:51.390 screenresolution[2012:19713] starting screenresolution argv=screenresolution get 03:57:51 INFO - 2015-11-13 03:57:51.394 screenresolution[2012:19713] Display 0: 1600x1200x32@60 03:57:51 INFO - 2015-11-13 03:57:51.401 screenresolution[2013:19716] starting screenresolution argv=screenresolution list 03:57:51 INFO - Available Modes on Display 0 03:57:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:57:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:57:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:57:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:57:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:57:51 INFO - Intel HD Graphics 3000: 03:57:51 INFO - Chipset Model: Intel HD Graphics 3000 03:57:51 INFO - Type: GPU 03:57:51 INFO - Bus: Built-In 03:57:51 INFO - VRAM (Total): 512 MB 03:57:51 INFO - VRAM (Dynamic, Max): 10 03:57:51 INFO - Vendor: Intel (0x8086) 03:57:51 INFO - Device ID: 0x0116 03:57:51 INFO - Revision ID: 0x0009 03:57:51 INFO - Displays: 03:57:51 INFO - Display: 03:57:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:57:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:57:51 INFO - Display Serial Number: 1600x1200 60 03:57:51 INFO - Main Display: Yes 03:57:51 INFO - Mirror: Off 03:57:51 INFO - Online: Yes 03:57:51 INFO - Rotation: Supported 03:57:51 INFO - Return code: 0 03:57:51 INFO - Running post-action listener: _resource_record_post_action 03:57:51 INFO - Running post-run listener: _resource_record_post_run 03:57:52 INFO - Total resource usage - Wall time: 1260s; CPU: 30.0%; Read bytes: 2895872; Write bytes: 688314368; Read time: 1441; Write time: 67874 03:57:52 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 342579712; Write bytes: 344862720; Read time: 38343; Write time: 10420 03:57:52 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 2854912; Write bytes: 342136832; Read time: 1408; Write time: 57399 03:57:52 INFO - Running post-run listener: _upload_blobber_files 03:57:52 INFO - Blob upload gear active. 03:57:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:57:52 INFO - Copying logs to upload dir... 03:57:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.983620 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2015-11-13 03:57:52.846897) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 03:57:52.850799) ========= 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.wFqUfkokw7/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.hOqNThr9ho/Listeners TMPDIR=/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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/y4EsqqoGQ1GdPv8ugNBelw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010319 build_url: 'https://queue.taskcluster.net/v1/task/y4EsqqoGQ1GdPv8ugNBelw/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-13 03:57:52.877801) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 03:57:52.878150) ========= 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.wFqUfkokw7/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.hOqNThr9ho/Listeners TMPDIR=/var/folders/30/tpgbx8fj64bgf_4zgl5c5ddr00000w/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.005543 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 03:57:52.928424) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 03:57:52.928793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 03:57:52.929276) ========= ========= Total master_lag: 0.23 =========