builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0003 starttime: 1447298169.69 results: success (0) buildid: 20151111170847 builduid: c28b6e5896a44a388afc0046ccbe17ed revision: a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:09.691612) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:09.692358) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:09.692686) ========= 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.7mOQ80Zb78/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.AApojZZoBu/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.006730 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:09.718141) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:09.718588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:09.832930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:09.833365) ========= 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.7mOQ80Zb78/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.AApojZZoBu/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.005736 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:09.857312) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:09.858189) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:09.859106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:09.859461) ========= 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.7mOQ80Zb78/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.AApojZZoBu/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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-11 19:16:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.45M=0.002s 2015-11-11 19:16:10 (7.45 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185972 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:10.154792) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:10.155148) ========= 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.7mOQ80Zb78/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.AApojZZoBu/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.020463 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:10.190863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-11 19:16:10.191286) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7mOQ80Zb78/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.AApojZZoBu/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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-11 19:16:10,270 truncating revision to first 12 chars 2015-11-11 19:16:10,270 Setting DEBUG logging. 2015-11-11 19:16:10,270 attempt 1/10 2015-11-11 19:16:10,270 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8ed7dd831d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 19:16:11,601 unpacking tar archive at: mozilla-central-a8ed7dd831d1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.595983 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-11 19:16:11.808216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:11.808729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:11.823029) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:11.823500) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 19:16:11.824016) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-11-11 19:16:11.824374) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7mOQ80Zb78/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.AApojZZoBu/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 19:16:12 INFO - MultiFileLogger online at 20151111 19:16:12 in /builds/slave/test 19:16:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:16:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:16:12 INFO - {'append_to_log': False, 19:16:12 INFO - 'base_work_dir': '/builds/slave/test', 19:16:12 INFO - 'blob_upload_branch': 'Firefox', 19:16:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:16:12 INFO - 'branch': 'Firefox', 19:16:12 INFO - 'buildbot_json_path': 'buildprops.json', 19:16:12 INFO - 'config_files': ('talos/mac_config.py',), 19:16:12 INFO - 'default_actions': ('clobber', 19:16:12 INFO - 'read-buildbot-config', 19:16:12 INFO - 'download-and-extract', 19:16:12 INFO - 'populate-webroot', 19:16:12 INFO - 'create-virtualenv', 19:16:12 INFO - 'install', 19:16:12 INFO - 'run-tests'), 19:16:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:16:12 INFO - 'download_minidump_stackwalk': True, 19:16:12 INFO - 'download_symbols': 'ondemand', 19:16:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:16:12 INFO - 'tooltool.py': '/tools/tooltool.py', 19:16:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:16:12 INFO - '/tools/misc-python/virtualenv.py')}, 19:16:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:16:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:16:12 INFO - 'installer_path': 'installer.exe', 19:16:12 INFO - 'log_level': 'info', 19:16:12 INFO - 'log_name': 'talos', 19:16:12 INFO - 'log_to_console': True, 19:16:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:16:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:16:12 INFO - 'opt_config_files': (), 19:16:12 INFO - 'pip_index': False, 19:16:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:16:12 INFO - 'cmd': ('bash', 19:16:12 INFO - '-c', 19:16:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:16:12 INFO - 'enabled': True, 19:16:12 INFO - 'halt_on_failure': False, 19:16:12 INFO - 'name': 'check_screen_resolution'},), 19:16:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:16:12 INFO - 'cmd': ('bash', 19:16:12 INFO - '-c', 19:16:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:16:12 INFO - 'enabled': True, 19:16:12 INFO - 'halt_on_failure': False, 19:16:12 INFO - 'name': 'check_screen_resolution'},), 19:16:12 INFO - 'run_cmd_checks_enabled': True, 19:16:12 INFO - 'sps_profile': False, 19:16:12 INFO - 'sps_profile_interval': 0, 19:16:12 INFO - 'suite': 'dromaeojs-e10s', 19:16:12 INFO - 'system_bits': '64', 19:16:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:16:12 INFO - 'title': 't-yosemite-r5-0003', 19:16:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:16:12 INFO - 'use_talos_json': True, 19:16:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:16:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:16:12 INFO - 'work_dir': 'build'} 19:16:12 INFO - ##### 19:16:12 INFO - ##### Running clobber step. 19:16:12 INFO - ##### 19:16:12 INFO - Running pre-action listener: _resource_record_pre_action 19:16:12 INFO - Running main action method: clobber 19:16:12 INFO - rmtree: /builds/slave/test/build 19:16:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:16:14 INFO - Running post-action listener: _resource_record_post_action 19:16:14 INFO - ##### 19:16:14 INFO - ##### Running read-buildbot-config step. 19:16:14 INFO - ##### 19:16:14 INFO - Running pre-action listener: _resource_record_pre_action 19:16:14 INFO - Running main action method: read_buildbot_config 19:16:14 INFO - Using buildbot properties: 19:16:14 INFO - { 19:16:14 INFO - "properties": { 19:16:14 INFO - "buildnumber": 10, 19:16:14 INFO - "product": "firefox", 19:16:14 INFO - "script_repo_revision": "production", 19:16:14 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 19:16:14 INFO - "repository": "", 19:16:14 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 19:16:14 INFO - "buildid": "20151111170847", 19:16:14 INFO - "slavename": "t-yosemite-r5-0003", 19:16:14 INFO - "pgo_build": "False", 19:16:14 INFO - "basedir": "/builds/slave/test", 19:16:14 INFO - "project": "", 19:16:14 INFO - "platform": "yosemite", 19:16:14 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:16:14 INFO - "slavebuilddir": "test", 19:16:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:16:14 INFO - "branch": "mozilla-central", 19:16:14 INFO - "repo_path": "mozilla-central", 19:16:14 INFO - "stage_platform": "macosx64", 19:16:14 INFO - "builduid": "c28b6e5896a44a388afc0046ccbe17ed", 19:16:14 INFO - "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a" 19:16:14 INFO - }, 19:16:14 INFO - "sourcestamp": { 19:16:14 INFO - "repository": "", 19:16:14 INFO - "hasPatch": false, 19:16:14 INFO - "project": "", 19:16:14 INFO - "branch": "mozilla-central-macosx64-talos", 19:16:14 INFO - "changes": [ 19:16:14 INFO - { 19:16:14 INFO - "category": null, 19:16:14 INFO - "files": [ 19:16:14 INFO - { 19:16:14 INFO - "url": null, 19:16:14 INFO - "name": "https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 19:16:14 INFO - } 19:16:14 INFO - ], 19:16:14 INFO - "repository": "", 19:16:14 INFO - "rev": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a", 19:16:14 INFO - "who": "kwierso@gmail.com", 19:16:14 INFO - "when": 1447297047, 19:16:14 INFO - "number": 6651754, 19:16:14 INFO - "comments": "Merge b2ginbound to central, a=merge", 19:16:14 INFO - "project": "", 19:16:14 INFO - "at": "Wed 11 Nov 2015 18:57:27", 19:16:14 INFO - "branch": "mozilla-central-macosx64-talos", 19:16:14 INFO - "revlink": "", 19:16:14 INFO - "properties": [ 19:16:14 INFO - [ 19:16:14 INFO - "buildid", 19:16:14 INFO - "20151111170847", 19:16:14 INFO - "Change" 19:16:14 INFO - ], 19:16:14 INFO - [ 19:16:14 INFO - "builduid", 19:16:14 INFO - "c28b6e5896a44a388afc0046ccbe17ed", 19:16:14 INFO - "Change" 19:16:14 INFO - ], 19:16:14 INFO - [ 19:16:14 INFO - "pgo_build", 19:16:14 INFO - "False", 19:16:14 INFO - "Change" 19:16:14 INFO - ] 19:16:14 INFO - ], 19:16:14 INFO - "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a" 19:16:14 INFO - } 19:16:14 INFO - ], 19:16:14 INFO - "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a" 19:16:14 INFO - } 19:16:14 INFO - } 19:16:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 19:16:14 INFO - Running post-action listener: _resource_record_post_action 19:16:14 INFO - ##### 19:16:14 INFO - ##### Running download-and-extract step. 19:16:14 INFO - ##### 19:16:14 INFO - Running pre-action listener: _resource_record_pre_action 19:16:14 INFO - Running main action method: download_and_extract 19:16:14 INFO - mkdir: /builds/slave/test/build/tests 19:16: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')]} 19:16:14 INFO - https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:16:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/test_packages.json 19:16:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/test_packages.json 19:16:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:16:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:16:15 INFO - Downloaded 1149 bytes. 19:16:15 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:16:15 INFO - Using the following test package requirements: 19:16:15 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:16:15 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:16:15 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 19:16:15 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:16:15 INFO - u'jsshell-mac.zip'], 19:16:15 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:16:15 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 19:16:15 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:16:15 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:16:15 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 19:16:15 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:16:15 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 19:16:15 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:16:15 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 19:16:15 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 19:16:15 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 19:16:15 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 19:16:15 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:15 INFO - https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:16:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:16:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:16:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:16:16 INFO - Downloaded 17454528 bytes. 19:16:16 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 19:16:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:16:16 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:16:22 INFO - Return code: 0 19:16:22 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 19:16:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:22 INFO - https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:16:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:16:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:16:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:16:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:16:23 INFO - Downloaded 17454528 bytes. 19:16:23 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 19:16:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 19:16:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 19:16:30 INFO - Return code: 0 19:16:30 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')]} 19:16:30 INFO - https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:16:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:16:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:16:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:16:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:16:30 INFO - Downloaded 11131693 bytes. 19:16:30 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 19:16:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 19:16:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 19:16:31 INFO - Return code: 0 19:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:31 INFO - https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 19:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/0p6A6oSaSzSFE5805Iut6Q/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 19:16:34 INFO - Downloaded 108701597 bytes. 19:16:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:16:34 INFO - mkdir: /builds/slave/test/properties 19:16:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:16:34 INFO - Writing to file /builds/slave/test/properties/build_url 19:16:34 INFO - Contents: 19:16:34 INFO - build_url:https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 19:16:34 INFO - Running post-action listener: _resource_record_post_action 19:16:34 INFO - Running post-action listener: set_extra_try_arguments 19:16:34 INFO - ##### 19:16:34 INFO - ##### Running populate-webroot step. 19:16:34 INFO - ##### 19:16:34 INFO - Running pre-action listener: _resource_record_pre_action 19:16:34 INFO - Running main action method: populate_webroot 19:16:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:16:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:16:34 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:16:34 INFO - '../fennec_ids.txt'], 19:16:34 INFO - 'tests': ['tcheck2']}, 19:16:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:16:34 INFO - '--tppagecycles', 19:16:34 INFO - '7'], 19:16:34 INFO - 'tests': ['tsvgm']}}, 19:16:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:16:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:16:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:16:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:16:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:16:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:16:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:16:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:34 INFO - 'talos_options': ['--e10s'], 19:16:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:16:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:34 INFO - 'tests': ['damp', 'tps']}, 19:16:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:34 INFO - 'talos_options': ['--e10s'], 19:16:34 INFO - 'tests': ['damp', 'tps']}, 19:16:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:16:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:16:34 INFO - 'other': {'tests': ['a11yr', 19:16:34 INFO - 'ts_paint', 19:16:34 INFO - 'tpaint', 19:16:34 INFO - 'sessionrestore', 19:16:34 INFO - 'sessionrestore_no_auto_restore']}, 19:16:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:16:34 INFO - 'tests': ['a11yr', 19:16:34 INFO - 'ts_paint', 19:16:34 INFO - 'tpaint', 19:16:34 INFO - 'sessionrestore', 19:16:34 INFO - 'sessionrestore_no_auto_restore']}, 19:16:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:16:34 INFO - 'tests': ['a11yr', 19:16:34 INFO - 'ts_paint', 19:16:34 INFO - 'tpaint', 19:16:34 INFO - 'sessionrestore', 19:16:34 INFO - 'sessionrestore_no_auto_restore']}, 19:16:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:16:34 INFO - 'tests': ['a11yr', 19:16:34 INFO - 'ts_paint', 19:16:34 INFO - 'tpaint', 19:16:34 INFO - 'sessionrestore', 19:16:34 INFO - 'sessionrestore_no_auto_restore']}, 19:16:34 INFO - 'other_l64': {'tests': ['a11yr', 19:16:34 INFO - 'ts_paint', 19:16:34 INFO - 'tpaint', 19:16:34 INFO - 'sessionrestore', 19:16:34 INFO - 'sessionrestore_no_auto_restore']}, 19:16:34 INFO - 'other_nol64': {'tests': ['a11yr', 19:16:34 INFO - 'ts_paint', 19:16:34 INFO - 'tpaint', 19:16:34 INFO - 'sessionrestore', 19:16:34 INFO - 'sessionrestore_no_auto_restore']}, 19:16:34 INFO - 'svgr': {'tests': ['tsvgx', 19:16:34 INFO - 'tsvgr_opacity', 19:16:34 INFO - 'tart', 19:16:34 INFO - 'tscrollx', 19:16:34 INFO - 'cart']}, 19:16:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:16:34 INFO - 'tests': ['tsvgx', 19:16:34 INFO - 'tsvgr_opacity', 19:16:34 INFO - 'tart', 19:16:34 INFO - 'tscrollx', 19:16:34 INFO - 'cart']}, 19:16:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:34 INFO - 'tests': ['tp5o']}, 19:16:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:34 INFO - 'talos_options': ['--e10s'], 19:16:34 INFO - 'tests': ['tp5o']}, 19:16:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:34 INFO - 'talos_options': ['--xperf_path', 19:16:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:16:34 INFO - 'tests': ['tp5n']}, 19:16:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:16:34 INFO - 'talos_options': ['--e10s', 19:16:34 INFO - '--xperf_path', 19:16:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:16:34 INFO - 'tests': ['tp5n']}}, 19:16:34 INFO - 'talos.zip': {'path': '', 19:16:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:16:34 INFO - Running post-action listener: _resource_record_post_action 19:16:34 INFO - ##### 19:16:34 INFO - ##### Running create-virtualenv step. 19:16:34 INFO - ##### 19:16:34 INFO - Running pre-action listener: _resource_record_pre_action 19:16:34 INFO - Running main action method: create_virtualenv 19:16:34 INFO - Creating virtualenv /builds/slave/test/build/venv 19:16:34 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 19:16:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:16:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:16:34 INFO - Using real prefix '/tools/python27' 19:16:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:16:35 INFO - Installing distribute.............................................................................................................................................................................................done. 19:16:39 INFO - Installing pip.................done. 19:16:39 INFO - Return code: 0 19:16:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:16:39 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')]} 19:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:39 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')]} 19:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:39 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 0x10cfba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf97228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feefbe4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cedd9f0>, '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 0x10cc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ced18c8>, '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.7mOQ80Zb78/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.AApojZZoBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 19:16:39 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 19:16:39 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 19:16:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7mOQ80Zb78/Render', 19:16:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:39 INFO - 'HOME': '/Users/cltbld', 19:16:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:39 INFO - 'LOGNAME': 'cltbld', 19:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:39 INFO - 'MOZ_NO_REMOTE': '1', 19:16:39 INFO - 'NO_EM_RESTART': '1', 19:16:39 INFO - 'PAGER': '/bin/cat', 19:16:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:39 INFO - 'PWD': '/builds/slave/test', 19:16:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:39 INFO - 'SHELL': '/bin/bash', 19:16:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AApojZZoBu/Listeners', 19:16:39 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 19:16:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:39 INFO - 'USER': 'cltbld', 19:16:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:39 INFO - 'XPC_FLAGS': '0x0', 19:16:39 INFO - 'XPC_SERVICE_NAME': '0', 19:16:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:40 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 19:16:40 INFO - Cleaning up... 19:16:40 INFO - Return code: 0 19:16:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:16:40 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')]} 19:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:40 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')]} 19:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:40 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 0x10cfba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf97228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feefbe4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cedd9f0>, '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 0x10cc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ced18c8>, '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.7mOQ80Zb78/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.AApojZZoBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 19:16:40 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 19:16:40 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 19:16:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7mOQ80Zb78/Render', 19:16:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:40 INFO - 'HOME': '/Users/cltbld', 19:16:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:40 INFO - 'LOGNAME': 'cltbld', 19:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:40 INFO - 'MOZ_NO_REMOTE': '1', 19:16:40 INFO - 'NO_EM_RESTART': '1', 19:16:40 INFO - 'PAGER': '/bin/cat', 19:16:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:40 INFO - 'PWD': '/builds/slave/test', 19:16:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:40 INFO - 'SHELL': '/bin/bash', 19:16:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AApojZZoBu/Listeners', 19:16:40 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 19:16:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:40 INFO - 'USER': 'cltbld', 19:16:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:40 INFO - 'XPC_FLAGS': '0x0', 19:16:40 INFO - 'XPC_SERVICE_NAME': '0', 19:16:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:40 INFO - Downloading/unpacking psutil>=0.7.1 19:16:40 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 19:16:40 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 19:16:40 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 19:16:40 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 19:16:40 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 19:16:40 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 19:16:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:16:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:16:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:16:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:16:43 INFO - Installing collected packages: psutil 19:16:43 INFO - Running setup.py install for psutil 19:16:43 INFO - building 'psutil._psutil_osx' extension 19:16:43 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 19:16:43 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 19:16:44 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 19:16:44 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 19:16:44 INFO - building 'psutil._psutil_posix' extension 19:16:44 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 19:16:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:16:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:16:44 INFO - ^ 19:16:44 INFO - 1 warning generated. 19:16:44 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 19:16:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:16:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:16:44 INFO - Successfully installed psutil 19:16:44 INFO - Cleaning up... 19:16:44 INFO - Return code: 0 19:16:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:16: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')]} 19:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16: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')]} 19:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16: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', '--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 0x10cfba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf97228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feefbe4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cedd9f0>, '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 0x10cc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ced18c8>, '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.7mOQ80Zb78/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.AApojZZoBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 19:16:44 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 19:16:44 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 19:16:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7mOQ80Zb78/Render', 19:16:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:44 INFO - 'HOME': '/Users/cltbld', 19:16:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:44 INFO - 'LOGNAME': 'cltbld', 19:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:44 INFO - 'MOZ_NO_REMOTE': '1', 19:16:44 INFO - 'NO_EM_RESTART': '1', 19:16:44 INFO - 'PAGER': '/bin/cat', 19:16:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:44 INFO - 'PWD': '/builds/slave/test', 19:16:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:44 INFO - 'SHELL': '/bin/bash', 19:16:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AApojZZoBu/Listeners', 19:16:44 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 19:16:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:44 INFO - 'USER': 'cltbld', 19:16:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:44 INFO - 'XPC_FLAGS': '0x0', 19:16:44 INFO - 'XPC_SERVICE_NAME': '0', 19:16:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:16:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:16:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:16:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:16:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:16:47 INFO - Installing collected packages: mozsystemmonitor 19:16:47 INFO - Running setup.py install for mozsystemmonitor 19:16:47 INFO - Successfully installed mozsystemmonitor 19:16:47 INFO - Cleaning up... 19:16:47 INFO - Return code: 0 19:16:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:47 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 0x10cfba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf97228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feefbe4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cedd9f0>, '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 0x10cc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ced18c8>, '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.7mOQ80Zb78/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.AApojZZoBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 19:16:47 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 19:16:47 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 19:16:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7mOQ80Zb78/Render', 19:16:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:47 INFO - 'HOME': '/Users/cltbld', 19:16:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:47 INFO - 'LOGNAME': 'cltbld', 19:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:47 INFO - 'MOZ_NO_REMOTE': '1', 19:16:47 INFO - 'NO_EM_RESTART': '1', 19:16:47 INFO - 'PAGER': '/bin/cat', 19:16:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:47 INFO - 'PWD': '/builds/slave/test', 19:16:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:47 INFO - 'SHELL': '/bin/bash', 19:16:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AApojZZoBu/Listeners', 19:16:47 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 19:16:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:47 INFO - 'USER': 'cltbld', 19:16:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:47 INFO - 'XPC_FLAGS': '0x0', 19:16:47 INFO - 'XPC_SERVICE_NAME': '0', 19:16:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:48 INFO - Downloading/unpacking blobuploader==1.2.4 19:16:48 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 19:16:48 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 19:16:48 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 19:16:48 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 19:16:48 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 19:16:48 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 19:16:50 INFO - Downloading blobuploader-1.2.4.tar.gz 19:16:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:16:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:16:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:16:51 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 19:16:51 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 19:16:51 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 19:16:51 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 19:16:51 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 19:16:51 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 19:16:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:16:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:16:51 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 19:16:51 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 19:16:51 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 19:16:51 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 19:16:51 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 19:16:51 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 19:16:52 INFO - Downloading docopt-0.6.1.tar.gz 19:16:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:16:52 INFO - Installing collected packages: blobuploader, requests, docopt 19:16:52 INFO - Running setup.py install for blobuploader 19:16:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:16:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:16:52 INFO - Running setup.py install for requests 19:16:53 INFO - Running setup.py install for docopt 19:16:53 INFO - Successfully installed blobuploader requests docopt 19:16:53 INFO - Cleaning up... 19:16:53 INFO - Return code: 0 19:16:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:53 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 0x10cfba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf97228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feefbe4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cedd9f0>, '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 0x10cc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ced18c8>, '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.7mOQ80Zb78/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.AApojZZoBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 19:16:53 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 19:16:53 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 19:16:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7mOQ80Zb78/Render', 19:16:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:53 INFO - 'HOME': '/Users/cltbld', 19:16:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:53 INFO - 'LOGNAME': 'cltbld', 19:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:53 INFO - 'MOZ_NO_REMOTE': '1', 19:16:53 INFO - 'NO_EM_RESTART': '1', 19:16:53 INFO - 'PAGER': '/bin/cat', 19:16:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:53 INFO - 'PWD': '/builds/slave/test', 19:16:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:53 INFO - 'SHELL': '/bin/bash', 19:16:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AApojZZoBu/Listeners', 19:16:53 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 19:16:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:53 INFO - 'USER': 'cltbld', 19:16:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:53 INFO - 'XPC_FLAGS': '0x0', 19:16:53 INFO - 'XPC_SERVICE_NAME': '0', 19:16:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:16:53 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-N_7LQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:16:54 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-0F8twL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:16:54 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-ZV8_Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:16:54 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-jWuqKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:16:54 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-oJVn0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:16:54 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-EWCzCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:16:54 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-nQorsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:16:54 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-kyI1dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:16:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:16:54 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-bkEPyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:16:55 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-pkPjxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:16:55 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-5rI5gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:16:55 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-2Wi3Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:16:55 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-c_afTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:16:55 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-JoyTI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:16:55 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-5A7Tpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:16:55 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-LROE1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:16:56 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-02Upza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:16:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:16:56 INFO - Running setup.py install for manifestparser 19:16:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:16:56 INFO - Running setup.py install for mozcrash 19:16:56 INFO - Running setup.py install for mozdebug 19:16:56 INFO - Running setup.py install for mozdevice 19:16:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:16:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:16:57 INFO - Running setup.py install for mozfile 19:16:57 INFO - Running setup.py install for mozhttpd 19:16:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:16:57 INFO - Running setup.py install for mozinfo 19:16:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:16:57 INFO - Running setup.py install for mozInstall 19:16:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:16:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:16:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:16:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:16:57 INFO - Running setup.py install for mozleak 19:16:57 INFO - Running setup.py install for mozlog 19:16:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:16:58 INFO - Running setup.py install for moznetwork 19:16:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:16:58 INFO - Running setup.py install for mozprocess 19:16:58 INFO - Running setup.py install for mozprofile 19:16:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:16:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:16:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:16:58 INFO - Running setup.py install for mozrunner 19:16:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:16:58 INFO - Running setup.py install for mozscreenshot 19:16:59 INFO - Running setup.py install for moztest 19:16:59 INFO - Running setup.py install for mozversion 19:16:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:16:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:16:59 INFO - Cleaning up... 19:16:59 INFO - Return code: 0 19:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:16:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10cfba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf97228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feefbe4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cedd9f0>, '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 0x10cc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ced18c8>, '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.7mOQ80Zb78/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.AApojZZoBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 19:16:59 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 19:16:59 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 19:16:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7mOQ80Zb78/Render', 19:16:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:16:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:16:59 INFO - 'HOME': '/Users/cltbld', 19:16:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:16:59 INFO - 'LOGNAME': 'cltbld', 19:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:16:59 INFO - 'MOZ_NO_REMOTE': '1', 19:16:59 INFO - 'NO_EM_RESTART': '1', 19:16:59 INFO - 'PAGER': '/bin/cat', 19:16:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:16:59 INFO - 'PWD': '/builds/slave/test', 19:16:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:16:59 INFO - 'SHELL': '/bin/bash', 19:16:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AApojZZoBu/Listeners', 19:16:59 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 19:16:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:16:59 INFO - 'USER': 'cltbld', 19:16:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:16:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:16:59 INFO - 'XPC_FLAGS': '0x0', 19:16:59 INFO - 'XPC_SERVICE_NAME': '0', 19:16:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:16:59 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-OdBO6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:17:00 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)) 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:17:00 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-IDWTNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:17:00 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)) 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:17:00 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-MHrdh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:17:00 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)) 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:17:00 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-kzXx5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:17:00 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)) 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:17:00 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-w6DluO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:17:00 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)) 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:17:00 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-fah8pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:17:00 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)) 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:17:00 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-mL2yfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:17:00 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)) 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:17:00 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-YlcRfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:17:00 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)) 19:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:17:00 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-RRbUB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:17:01 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)) 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:17:01 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-3JGYao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:17:01 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)) 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:17:01 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-y3Jh6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:17:01 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)) 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:17:01 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-9cwC8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:17:01 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)) 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:17:01 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-sLPl1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:17:01 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)) 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:17:01 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-pD0NLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:17:01 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)) 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:01 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-rvfyhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:17:01 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)) 19:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:17:01 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-JN00x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:17:02 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)) 19:17:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:17:02 INFO - Running setup.py (path:/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/pip-eAgjHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:17:02 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)) 19:17:02 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)) 19:17:02 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)) 19:17:02 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)) 19:17:02 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)) 19:17:02 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)) 19:17:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:17:02 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 19:17:02 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 19:17:02 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 19:17:02 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 19:17:02 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 19:17:02 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 19:17:04 INFO - Downloading blessings-1.5.1.tar.gz 19:17:04 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 19:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:17:05 INFO - Installing collected packages: blessings 19:17:05 INFO - Running setup.py install for blessings 19:17:05 INFO - Successfully installed blessings 19:17:05 INFO - Cleaning up... 19:17:05 INFO - Return code: 0 19:17:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:17:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:17:05 INFO - Reading from file tmpfile_stdout 19:17:05 INFO - Current package versions: 19:17:05 INFO - blessings == 1.5.1 19:17:05 INFO - blobuploader == 1.2.4 19:17:05 INFO - docopt == 0.6.1 19:17:05 INFO - manifestparser == 1.1 19:17:05 INFO - mozInstall == 1.12 19:17:05 INFO - mozcrash == 0.16 19:17:05 INFO - mozdebug == 0.1 19:17:05 INFO - mozdevice == 0.47 19:17:05 INFO - mozfile == 1.2 19:17:05 INFO - mozhttpd == 0.7 19:17:05 INFO - mozinfo == 0.9 19:17:05 INFO - mozleak == 0.1 19:17:05 INFO - mozlog == 3.0 19:17:05 INFO - moznetwork == 0.27 19:17:05 INFO - mozprocess == 0.22 19:17:05 INFO - mozprofile == 0.27 19:17:05 INFO - mozrunner == 6.11 19:17:05 INFO - mozscreenshot == 0.1 19:17:05 INFO - mozsystemmonitor == 0.0 19:17:05 INFO - moztest == 0.7 19:17:05 INFO - mozversion == 1.4 19:17:05 INFO - psutil == 3.1.1 19:17:05 INFO - requests == 1.2.3 19:17:05 INFO - wsgiref == 0.1.2 19:17:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:17: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')]} 19:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17: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')]} 19:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:17:05 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 0x10cfba490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf97228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feefbe4a8c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cedd9f0>, '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 0x10cc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ced18c8>, '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.7mOQ80Zb78/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.AApojZZoBu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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 19:17:05 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 19:17:05 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 19:17:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7mOQ80Zb78/Render', 19:17:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:17:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:17:05 INFO - 'HOME': '/Users/cltbld', 19:17:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:17:05 INFO - 'LOGNAME': 'cltbld', 19:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:05 INFO - 'MOZ_NO_REMOTE': '1', 19:17:05 INFO - 'NO_EM_RESTART': '1', 19:17:05 INFO - 'PAGER': '/bin/cat', 19:17:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:05 INFO - 'PWD': '/builds/slave/test', 19:17:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:17:05 INFO - 'SHELL': '/bin/bash', 19:17:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AApojZZoBu/Listeners', 19:17:05 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 19:17:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:17:05 INFO - 'USER': 'cltbld', 19:17:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:17:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:05 INFO - 'XPC_FLAGS': '0x0', 19:17:05 INFO - 'XPC_SERVICE_NAME': '0', 19:17:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 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)) 19:17:05 INFO - Cleaning up... 19:17:05 INFO - Return code: 0 19:17:05 INFO - Running post-action listener: _resource_record_post_action 19:17:05 INFO - Running post-action listener: _start_resource_monitoring 19:17:06 INFO - Starting resource monitoring. 19:17:06 INFO - ##### 19:17:06 INFO - ##### Running install step. 19:17:06 INFO - ##### 19:17:06 INFO - Running pre-action listener: _resource_record_pre_action 19:17:06 INFO - Running main action method: install 19:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:17:06 INFO - Reading from file tmpfile_stdout 19:17:06 INFO - Detecting whether we're running mozinstall >=1.0... 19:17:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:17:06 INFO - Reading from file tmpfile_stdout 19:17:06 INFO - Output received: 19:17:06 INFO - Usage: mozinstall [options] installer 19:17:06 INFO - Options: 19:17:06 INFO - -h, --help show this help message and exit 19:17:06 INFO - -d DEST, --destination=DEST 19:17:06 INFO - Directory to install application into. [default: 19:17:06 INFO - "/builds/slave/test"] 19:17:06 INFO - --app=APP Application being installed. [default: firefox] 19:17:06 INFO - mkdir: /builds/slave/test/build/application 19:17:06 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'] 19:17:06 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 19:17:47 INFO - Reading from file tmpfile_stdout 19:17:47 INFO - Output received: 19:17:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:17:47 INFO - Running post-action listener: _resource_record_post_action 19:17:47 INFO - ##### 19:17:47 INFO - ##### Running run-tests step. 19:17:47 INFO - ##### 19:17:47 INFO - Running pre-action listener: _resource_record_pre_action 19:17:47 INFO - Running main action method: run_tests 19:17:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:17:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:17:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:17:47 INFO - 2015-11-11 19:17:47.620 screenresolution[1917:17773] starting screenresolution argv=screenresolution get 19:17:47 INFO - 2015-11-11 19:17:47.624 screenresolution[1917:17773] Display 0: 1600x1200x32@60 19:17:47 INFO - 2015-11-11 19:17:47.631 screenresolution[1918:17775] starting screenresolution argv=screenresolution list 19:17:47 INFO - Available Modes on Display 0 19:17:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:17:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:17:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:17:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:17:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:17:47 INFO - Intel HD Graphics 3000: 19:17:47 INFO - Chipset Model: Intel HD Graphics 3000 19:17:47 INFO - Type: GPU 19:17:47 INFO - Bus: Built-In 19:17:47 INFO - VRAM (Total): 512 MB 19:17:47 INFO - VRAM (Dynamic, Max): 10 19:17:47 INFO - Vendor: Intel (0x8086) 19:17:47 INFO - Device ID: 0x0116 19:17:47 INFO - Revision ID: 0x0009 19:17:47 INFO - Displays: 19:17:47 INFO - Display: 19:17:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:17:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:17:47 INFO - Display Serial Number: 1600x1200 60 19:17:47 INFO - Main Display: Yes 19:17:47 INFO - Mirror: Off 19:17:47 INFO - Online: Yes 19:17:47 INFO - Rotation: Supported 19:17:47 INFO - Return code: 0 19:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:17:47 INFO - Python 2.7.3 19:17:47 INFO - Return code: 0 19:17:47 INFO - grabbing minidump binary from tooltool 19:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:17:47 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 0x10cedd9f0>, '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 0x10cc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ced18c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:17:47 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 19:17:47 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 19:17:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:17:48 INFO - Return code: 0 19:17:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:17:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:17:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:17:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:17:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0003', '--webServer', 'localhost'] in /builds/slave/test/build 19:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0003 --webServer localhost 19:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7mOQ80Zb78/Render', 19:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:17:48 INFO - 'HOME': '/Users/cltbld', 19:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:17:48 INFO - 'LOGNAME': 'cltbld', 19:17:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:17:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:17:48 INFO - 'MOZ_NO_REMOTE': '1', 19:17:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:17:48 INFO - 'NO_EM_RESTART': '1', 19:17:48 INFO - 'PAGER': '/bin/cat', 19:17:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:17:48 INFO - 'PWD': '/builds/slave/test', 19:17:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:17:48 INFO - 'SHELL': '/bin/bash', 19:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AApojZZoBu/Listeners', 19:17:48 INFO - 'TMPDIR': '/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/', 19:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:17:48 INFO - 'USER': 'cltbld', 19:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:17:48 INFO - 'XPC_FLAGS': '0x0', 19:17:48 INFO - 'XPC_SERVICE_NAME': '0', 19:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 19:17:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0003', '--webServer', 'localhost'] with output_timeout 3600 19:17:48 INFO - mozversion INFO | application_buildid: 20151111170847 19:17:48 INFO - mozversion INFO | application_changeset: a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a 19:17:48 INFO - mozversion INFO | application_display_name: Nightly 19:17:48 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:17:48 INFO - mozversion INFO | application_name: Firefox 19:17:48 INFO - mozversion INFO | application_remotingname: firefox 19:17:48 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 19:17:48 INFO - mozversion INFO | application_vendor: Mozilla 19:17:48 INFO - mozversion INFO | application_version: 45.0a1 19:17:48 INFO - mozversion INFO | platform_buildid: 20151111170847 19:17:48 INFO - mozversion INFO | platform_changeset: a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a 19:17:48 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 19:17:48 INFO - mozversion INFO | platform_version: 45.0a1 19:17:48 INFO - 2015-11-11 19:17:48,308 DEBUG : using testdate: 1447298268 19:17:48 INFO - 2015-11-11 19:17:48,308 DEBUG : actual date: 1447298268 19:17:48 INFO - 2015-11-11 19:17:48,318 INFO : starting webserver on 'localhost:56412' 19:17:48 INFO - 2015-11-11 19:17:48,319 INFO : Starting test suite t-yosemite-r5-0003.e 19:17:48 INFO - 2015-11-11 19:17:48,319 INFO : Starting test dromaeo_css 19:17:48 INFO - 2015-11-11 19:17:48,319 DEBUG : operating with platform_type : mac_ 19:17:48 INFO - 2015-11-11 19:17:48,320 INFO : Initialising browser for dromaeo_css test... 19:17:48 INFO - 2015-11-11 19:17:48,336 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpwzUWCd/profile http://localhost:56412/getInfo.html 19:17:51 INFO - 2015-11-11 19:17:51,931 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:17:51 INFO - 2015-11-11 19:17:51,932 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:17:51 INFO - 2015-11-11 19:17:51,932 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:17:51 INFO - 2015-11-11 19:17:51,932 DEBUG : BROWSER_OUTPUT: __metrics 19:17:52 INFO - 2015-11-11 19:17:52,647 INFO : Browser initialized. 19:17:52 INFO - 2015-11-11 19:17:52,648 INFO : Running cycle 1/1 for dromaeo_css test... 19:17:52 INFO - 2015-11-11 19:17:52,648 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpwzUWCd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:18:05 INFO - 2015-11-11 19:18:05,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 241987584 19:18:05 INFO - 2015-11-11 19:18:05,004 DEBUG : BROWSER_OUTPUT: 19:18:54 INFO - 2015-11-11 19:18:54,762 DEBUG : BROWSER_OUTPUT: 1447298334756 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] 19:21:04 INFO - 2015-11-11 19:21:04,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56412/tests/dromaeo/cssquery-ext.html) 19:21:05 INFO - 2015-11-11 19:21:05,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 268324864 19:21:05 INFO - 2015-11-11 19:21:05,911 DEBUG : BROWSER_OUTPUT: 19:24:08 INFO - 2015-11-11 19:24:08,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/dromaeo/cssquery-ext.html (next: http://localhost:56412/tests/dromaeo/cssquery-jquery.html) 19:24:08 INFO - 2015-11-11 19:24:08,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 273690624 19:24:08 INFO - 2015-11-11 19:24:08,640 DEBUG : BROWSER_OUTPUT: 19:27:10 INFO - 2015-11-11 19:27:10,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56412/tests/dromaeo/cssquery-mootools.html) 19:27:10 INFO - 2015-11-11 19:27:10,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 277786624 19:27:10 INFO - 2015-11-11 19:27:10,956 DEBUG : BROWSER_OUTPUT: 19:30:12 INFO - 2015-11-11 19:30:12,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56412/tests/dromaeo/cssquery-prototype.html) 19:30:13 INFO - 2015-11-11 19:30:13,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 281174016 19:30:13 INFO - 2015-11-11 19:30:13,352 DEBUG : BROWSER_OUTPUT: 19:33:15 INFO - 2015-11-11 19:33:15,973 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56412/tests/dromaeo/cssquery-yui.html) 19:33:16 INFO - 2015-11-11 19:33:16,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 286658560 19:33:16 INFO - 2015-11-11 19:33:16,575 DEBUG : BROWSER_OUTPUT: 19:36:18 INFO - 2015-11-11 19:36:18,814 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/dromaeo/cssquery-yui.html (next: http://localhost:56412/tests/dromaeo/cssquery-dojo.html) 19:36:19 INFO - 2015-11-11 19:36:19,060 DEBUG : BROWSER_OUTPUT: RSS: Main: 290951168 19:36:19 INFO - 2015-11-11 19:36:19,060 DEBUG : BROWSER_OUTPUT: 19:36:19 INFO - 2015-11-11 19:36:19,061 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:36:19 INFO - 2015-11-11 19:36:19,061 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:36:19 INFO - 2015-11-11 19:36:19,061 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:36:19 INFO - 2015-11-11 19:36:19,062 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:36:19 INFO - 2015-11-11 19:36:19,063 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2621.5936529837877;2698.365884017257;2751.76609988151;2766.847823369715;2768.7784977201827;4691.8592442226745;4727.645426593006;4738.47876733559;4763.737994410306;4792.400949881265;4600.17196904557;4612.8385506507275;4658.953410465894;4699.38907941968;4777.976110119454;4305.160493703729;4350.456192975878;4397.604215620593;4397.956020439803;4427.1367083418745;216.7637081174607;4153.646141118071;4441.489228738704;4456.353828694853;4544.568266014723;4268.637165840907;4296.5273819879785;4314.935275970847;4349;4379.627731642814;4337.240982828024;4432.490263619693;4441.022974945507;4452.332150177467;4484.730916145042;4173.144505376391;4385.649148068179;4399.252127138394;4438.933415998763;4444.422225110748;4356.411884395629;4436.534163912775;4505.43682039745;4605.286180642006;4637.420322459692;4929.65492415531;4935.654354901301;4986.850394488171;5002.699838009695;5031.572316353077;4738.455077666078;4938.678985865943;4953.2570114483115;5099.566536844372;5139.15203991341;4691.319758635013;4720.527947205286;4734;4776.283557466373;4777.140114779373;5070.416902056237;5087.3386459759995;5144.948550514522;5155.432902380735;5166.044281807877;4729.054189162112;4908.067467181224;4928.926066109011;5009.373828271466;5062.82280120194;5022.723750193774;5028.547430731252;5087.949120508822;5095.031943930641;5110.565601923804;4997.525235102659;5002.1496345621335;5013.323201367842;5025.974870125626;5033.1695270280725;4627.583517483443;4644.7213167210075;4924.630652701062;4971.6271279654175;5034.874128146826;3857.4792403025795;3890.2025084857537;3898.142408670088;3926.0577461409057;3928.842846286174;3452.1197094741183;3539.2744487380023;3549.6095429502734;3568.6074531801482;3593.317269718745;4627.1439783640135;4662.860114196579;4703.388559487314;4729.5743383095;4778.546038126373;5102.36220472441;5109.489051094935;5117.104506711311;5158.458361872024;5200.115980283361;4479.619232365286;4587;4744.881377965578;4799;4887.169181239198;4451.354553589711;4473;4491.393661855673;4500.617447516997;4526.751028693454;4952.133376659142;5214.296070030573;5219.42586315505;5246.580273578104;5250.65870718402;4790.305405716082;4837.733924634179;4966.056449274626;5096.541311282002;5118.181091025418;5130.948690513047;5235.502627250406;5238.921416178684;5248.947510524846;5299.7615107321035;4896.338994235733;4906.288588154769;5004.2493625956395;5005.024020316004;5055.1153548128195;4767.380240568704;4841.491643377394;5007.123753343078;5080.847574572768;5134.768935397841;4859.4654587996;4941.135301322326;4965.925511117264;4977.601791856715;5014.222795466709;4895.828645997373;4915.3855768029;4949.406071271471;4963.10664080469;5027.396712394536;4648.860534183845;4744.288356746378;4752.310914917249;4773.140834649657;4804.039192161652;4744.762761861962;4804.447488538863;4863.173260545645;4918.336024636628;4921.212605983025;4686.039361930728;4804.759762011955;4838.806447742051;4846.345743324606;4875.268709693574 19:36:19 INFO - 2015-11-11 19:36:19,067 DEBUG : BROWSER_OUTPUT: |1;ext.html;456.2130325189049;461.7552697070554;476.8068932082506;490.0126245615084;501.6338073206557;30905.536416953735;31581.526277105862;31600.52599211008;31771.68228317716;31882;34647;35627.64372356276;35710.64289357106;36146.638533614656;36734;7660.693572257103;7830.647620857075;7831.138574756772;7832.530048197098;7863.8034049148655;7652.732154374598;7779.144294127642;7786.065672119354;7788.415868809833;7792.571408572526;7795.064592248938;7902.130765615778;7918.604069796516;7956.562389068599;8027.799305017363;7812.414068944823;7860.331871790904;7863.410244231677;7872;7961.681532738741;7720.15078341382;7757.612119394064;7779.7666070017995;7795.493292935941;7836.843263134762;33474;33951.32097358039;33987.66012339894;34149.90201175875;34206.657933420596;2245.955080898389;2381.666566680666;2523.2682522068576;2538.923832285034;2725.1824452664123;22972.65541016886;23271.767282327128;23272.53454930909;23486.530269394687;24212.757872421225;1890.6029733755927;1939.3890924358782;1971.5662554238045;1976.4070778766313;2055.804698553635;212176;214773.92613036992;215016;215760;216057;42847.35728964068;49592.256116158285;49812.50187498151;49830;50049;44360.55639443629;50562.494375056514;52342.21486677703;52705.73647131817;52918;14153.929230353782;14339.494353092983;14620.780688289684;14651;14790;10895.128389728803;10977.28647637901;10993.670189894156;10997.780044399067;11015.614453494249;16203.756943645854;16425.83574164267;16431.342746290255;16671.49985500437;16756.581085472717;7284.453665975073;7469.215732348134;7481.812954676067;7512.699492020367;7531.209223031503;761.3604572159413;859.6518410043817;886.902440731519;905.5472263868066;937.2314701944476;24060.39849003789;24062.15782447606;24283.878580607336;24361.63457548138;24475.510489790104;894.552723638181;929.7350255177242;933.2300851797295;945.6926498887889;974.5322245322285;12648.177868438706;12651.936740316423;12689.302088385228;12757.48970041188;12777.616671499869;257466;263729;263917;264454;265295;45963.54036459592;47112.29331560029;47163;47212;47331;1175.7178277213407;1197.7484728207173;1202.7834989701762;1208.3354155214597;1218.056006594896;23906.425732923584;24357.39106522351;24397.878010609835;24487.14294999738;24606.876965615058;40789.796051019555;40871.79564102161;41092.794536027126;41137.58862411338;41316.1736765269;238059;240715;240985;241385;242212;26595.33511662224;27010.864945675145;27121.1863644091;27131.321716957234;27133.0657054722;31642;32266.516002259516;32869;33114.834425827714;33128.50307245441;26945.461090778466;29820.85089574538;29958.70041299559;30108.24729381783;32125.357492849544;28985.855070724512;29509.786765993067;29818.254543636584;29924.85037574798;30238.244043899078;27966.44067118687;28856.2785930345;29138.854305728335;29301.120966371043;29396.118116455684;22743.88628056849;25064;25353.239402817944;26411.735882641697;27050.32374190661;19885.701714474584;20283.188672452936;20317.49206269855;20559.38321850347;20603.381898543066 19:36:19 INFO - 2015-11-11 19:36:19,067 DEBUG : BROWSER_OUTPUT: |2;jquery.html;282.48023636508844;288.0752783564757;288.37422792540184;290.62944745449556;294.3069072334652;12901.22592644442;14530.273486325681;14822.481213157529;14942.775858362133;15220.391184352613;15064.548063558083;15213.315400806963;15675.764863527056;15688.921555392235;15807.209639518036;3986.8604598839047;4069.9389509157386;4140.544540100586;4161.667066634662;4593.448786145667;4035.8587449439274;4091.529474110486;4119.814608342616;4127.17456508698;4127.587241275864;2910.7089291070934;3450.6031806342216;4060.3909413587903;4094.2220978014084;4107.219628270634;4077.55146933837;4113.095119073799;4117.341225403936;4119.629233369011;4138.772367519785;3466.757326987112;3486.0936156599214;3497.405441075023;3521.154922818531;3530.3292374448774;11138.27601205919;11361.715957101138;11429.428528573539;11533.711657208552;11553.53785848565;1630.9102999335032;1634.6648936967892;1647.7281248593968;1660.6512632347221;1689.1300979995312;7427.960085587968;7727.343175830061;7772.611369431563;7832.020997375328;7855.607219638995;1303.3287856753684;1326.515821725073;1345.8384993800807;1354.8916086713039;1361.8297712785902;49445.752771235915;51244;51331.23003154918;51730.741346293406;52140.47859521394;5436.347638283352;5440.863978400572;5544.3346798383645;5563.360213575491;5621.437856214346;6313.747450102036;6332.398422149889;6335.36646335372;6410.038494225903;6412.102305677209;4474.6867719259335;4570.291604801195;4648;4679.906401871944;4694.084653492536;4923.48303428142;4956.677815941952;4986.351774269322;4993.350864387607;5020.246962955513;2467.198160597813;2484.962725559118;2515.811314151446;2523.684539432571;2524.835885667426;868.4658934755206;884.425123669607;889.3374436045059;891.5007595746403;935.2424536125624;359.1309032142222;374.5262243262275;379.2301627695782;384.9364854798983;386.36250187190797;8551.700690475804;9986;10359.533820978075;10438.425886576311;10459.424731639832;381.8625294893836;387.1637263510803;390.7225869632593;391.8119302734646;392.880171547675;5397.514223719884;5532.225488431623;5578.163275508625;5587.720613969285;5649.604527683105;447181.8204544847;451700;468145;468694;468967;59903.400965989786;61132.69433652803;61772.38227617756;62017;62432.06351904725;426.9231538323132;427.20326590908354;429.1781238927419;429.8860801887502;431.94168787213323;9127.817443650956;9350.625974960925;9364.578593963424;9384.95307523458;9661.178799802095;30541.389172215986;30602.234944126576;30696.84651576728;30842.228944276572;30892.22769430782;42234.67709275896;42253.57746422497;42346.576534234264;42987.78506107449;43187.13625727405;5195.818146364859;5299.258103865539;5313.601479888946;5397.406285308692;5427.1316589345515;10133.442660653734;10230.693079207636;10247.487625618838;10359.22305827081;10373.170146388422;8633.223009929137;8839.734807955772;8890.73327800167;8939.195472407515;8982.832231809823;7244.710211591478;8421.621027053674;8439.071702112886;8483.957580212307;8523.701670441505;8643.17889800468;8656.091110433566;8804;8859.51272679983;8914.73255802327;5179.766910489112;5191.532762051283;5211.426743058337;5258.237555554347;5291.470852914832;8439.70461033861;8605.784855378666;8681.305495560466;8697.52163630981;8715.34634902372 19:36:19 INFO - 2015-11-11 19:36:19,071 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1456.4101538876755;1481.1779462398365;1500.5423345879503;1500.9399624015034;1505.8870584706146;6046.727897244624;6152.446279834814;6255.405736455035;6448.871022579546;6489.935100648992;6663.20041595008;6745.76389826355;6778.254392016875;6794.150731158606;6896.137982752156;1889.5842914558775;1893.8958357290344;1926;1929.7394851694983;1956.9412917612424;1923.8941858197793;1950.9024548772575;1964.6561851675972;1981.9207231710714;1994.341867183833;1934.264979307861;1957.725918371429;1958.9902050489727;1961.3723608445302;1977.5352792093847;1896.1183049881802;1938.060040880179;1942;1968.980310196894;1976.5849171673965;1895.2987394663924;1912.4931893048354;1934.0813113770987;1951.6487032334173;1961.794011628787;6888.793336199922;6898.034275201476;6935.757248496328;6990.4757143214465;7027.227005029443;4110.979445102786;4205.11692544566;4216.325387937915;4224.978875105605;4294.227039132955;2235.452314183019;2292.5071109711325;2491.9003239870385;2597.7662010419153;2613.973860261392;720.1610124205295;726.2374506767925;771.4368510986955;771.9498232614862;783.0603276068683;9151.405158664666;9177.265818734551;9187.632494700203;9306.627734890664;9323.906760932372;3752.0432289765936;3765.0963768695865;3840.116773142193;3879.301725689403;3925.9018524536546;7871.960640196762;7988.320992715684;8075.636596353178;8084.3936704747375;8150.184981501802;4288.506821715543;4292.334688123346;4293.549177336397;4299.118680670455;4362.302031674917;3882.3011857865854;3889.1638297766117;3927.1360300734364;3943.546492153439;3957;3214.8714051438146;3285.589301337333;3300.85146168423;3318.7720543399096;3340.4822252550894;1072.855164552791;1081.864766904137;1087.5486673030603;1088.455772113943;1088.4992903264429;1101.6089288302537;1103.426218366445;1119.5242022140558;1122.2873475343215;1151.78691941991;6314.810555683337;6374.872502549923;6406.039094135824;6429.485641148697;6480.4815614750705;990.6186118344345;1054.7890421915647;1062.4953147255146;1076.0530732954949;1089.624079692505;5064.088464076428;5139.7687104080405;5145.382554093533;5151.330327057459;5177.534021938043;7295.635218239173;7669.578173200416;8039.718609848627;8051.39614528901;8062.717804876801;7678.923210767933;7760.417968652374;7963.761087167394;7999.600019998977;8120.3503719702285;6269.341719119518;6330.651814150174;6424.421802037839;6429.903551446732;6485.935140648533;6280;6343.207099112611;6431.839204019937;6434.678266086583;6448.935510644834;6921.377076063179;7214.96392518034;7241.637918104179;7253.274672532704;7267.491275610657;7245.818854528468;7320.524165929198;7429.257074292527;7456.366208872307;7534.736284230025;6064.545159113172;6078.3921607838865;6098.512119030555;6146.631202127886;6174.845628859135;6542.869142617216;6546.378094081055;6608.471322294301;6674.065630811788;6679.4656427484715;6187.84530386744;6235.282942461675;6259.217597800275;6260.436560709558;6307.495400367868;5944.821655350346;6006.639601623741;6118.20463339763;6152.384761523812;6168.938310617016;6201.627902325875;6215.7873859579895;6262.686865656608;6286.654234017173;6319.494440444845;5595.412481689526;5629.577781666309;5680.034394152921;5697.202391665087;5728.140778883034;5725.742341594721;5778.393268706894;5779.335376431596;5782.508486778671;5786.30564332266 19:36:19 INFO - 2015-11-11 19:36:19,072 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.28509390783222;258.760646402078;266.85323072310223;268.26762937181496;280.6632041550138;5199.454057323978;5274.73626318684;5303.787848486056;5303.814366497164;5333.120035194198;5268.025415298163;5298.973505132479;5304.496072873071;5306.097963346231;5329.653572517794;4126.174765046988;4166.10428757817;4182.665386769067;4199.895002624929;4213.30480470722;4161.854335098272;4166.625003749662;4179.3939878717565;4201.306784380574;4205.579442055785;4047.534533528638;4074;4144.813483393239;4167.666586673074;4169.5830416958215;4192.7484350938885;4197.265478541243;4216.936745948813;4218.78906054696;4228.746275223496;3602.225521512887;3610.494530765695;3621.0947263184203;3630.3828349180703;3658.268346330718;5021.799128034874;5022.522860328299;5112.207607820794;5176.508231718019;5325.547328477084;4386.473623165209;4429.778511074465;4468.374427580141;4511.1654343946475;4518.231900576877;5383.111786555253;5435.972820135914;5500;5533.170024496318;5557.527610153142;3670.064133645903;3673.3938900081453;3680.2271522980204;3689.2252626948375;3739.364308067635;5717.228174196472;5725.799597014085;5728.541716662657;5787.73955172014;5813.912791308091;3739.08392443853;3740.588535261119;3744.1762812181278;3765;3803.1062700265416;3805.4862593549515;3810.314143454205;3813.142043040349;3862.1117143057254;3879.689624830063;4447.177272204653;4448.955510444919;4501.369808226851;4509.729416235036;4510.8421205257655;5458.863528411822;5578.163275508706;5621.831345059655;5635.6618602883955;5645.604807663424;1341.684704094537;1386.3414877933103;1403.0389183409397;1407.6691977385306;1408.4436647524376;880.1330689271063;892.0989800301742;899.7435730816686;900.7612982559627;908.981820363589;5327.307450031549;5353.973230133903;5366.6243362964215;5404.054290499147;5426.321709786277;5883.794067207627;5891.086881533369;5895.67573783446;5914.467697907209;5973.910391344133;5304.045271851104;5357.919631205535;5359.973200133974;5370.892582148335;5400.324959380077;3155.684431556872;3204.4872820348633;3227.402930457873;3235.919102022421;3255.5930508686415;5838.2702162229725;5966.19456373384;6011.368806275278;6015.849603759941;6043.7884674036195;5813;5882.264716910387;5886.676232807151;5893.852653683606;5998.580099393001;6027.21646185993;6089.634621922699;6143.600665956787;6151.0773383992755;6194.0708893666315;5824.446677565625;5855.209546711139;5894.469497745224;5934.465898069022;5938.109283607493;5549.389567147691;5707.258056452801;5724.484796368347;5782.7686892523825;5792.855178620568;6008.939910600838;6018.849528761816;6094.512439004958;6100.877982440237;6113.633182009094;3753.981230093832;3755.75587586806;3811.6378944000276;3827.7129215308405;3864.381698928158;5736.627119237236;5826.854328641818;5828.038373668297;5836.562257830765;5856.736446859816;5455.8363249102595;5598.86002849932;5668.773249069991;5740.1102829061565;5774.9133762994425;5630.690312032878;5653.660780353192;5658.858528536654;5662.490375866192;5773.04744717117;5509.449055094458;5560.721963901708;5566.638168519034;5595.720213989202;5644.238027866186;5570.5265052470995;5588.077967135378;5654.745536450787;5663.150527420755;5697.857553561194;5492.780288788564;5575.721213939368;5584.553235741212;5590.189422533791;5594.244776955059 19:36:19 INFO - 2015-11-11 19:36:19,075 DEBUG : BROWSER_OUTPUT: |5;yui.html;527.8390091022239;528.9973550132249;537.7230726176018;640.894252448346;669.0800149794034;11613.941930290348;11885.643430697071;11913.880861191385;11915.940420297897;11974.401279936;9653.565589548469;11131.777364452726;11286.435678216098;11292.604758833442;11380.374079425628;756.247533703964;769.29225112896;773.4585789947059;774.8798936164903;777.0054330457024;775.5579319787723;783.7805414483925;789.1831953927687;791.70311133325;796.8047828282079;821.2731732416825;824.3775949158407;824.4229039672224;830.6469750356105;832.2094010689839;773.9496932699357;799.2526987266895;805.697863301262;815.8980127484065;816.9019717633893;602.8824379246049;603.2790814976062;603.4478452216217;604.1692672575209;604.3412680178626;11416.372099534605;11752.58865939688;11764.058875289957;11790.94104529472;11877.22798018126;9851.162651174658;9940.701778946572;10155;10213.846792298122;10319;7898.60506974649;7910.367170626336;8087.312578430781;8142.267195952333;8209.83580328396;2801.9159425217276;2827.3497095668113;2922.021122923823;2939.4873126613707;2972.8513574321196;41887;42588;42691.359629605584;42723;43125;7687.385009199251;7704.768856934301;7787.92212077872;7798.543458810456;7943.205679432011;16357.427490037791;16527.752083718755;16539.84221104511;16557.668846623;16862.91568542174;5715.228444159985;5918.970405147947;5934.584579079509;6036.8188954331445;6188.195534580565;3212.8072315661134;3315.336932613487;3400.217949871494;3405.5913290404815;3496.790192588453;2492.2772396004957;2557.667503224606;2558.270892795544;2594.532984062849;2600.557905156128;409.1673444540346;410.5894105894106;411.36444193720774;419.38141241668905;421.1555830559708;379.7884747654972;448.7733694484265;461.9974654998661;475.3630135618219;534.9117395629678;5990;6188.8762224755255;6281.183446152062;6335.841603959938;6468.06213099098;433.85682724700774;484.4534047959852;495.79176745766864;501.8607760383908;515.5875299760177;3090.799098058619;3206.3587282543585;3241.092494101655;3334.299797042648;3406.608240052376;49052;49383;49767.75116124396;50112;50895.23657145146;41960.160796784505;42108.789456052524;42999.14001719948;45287;46523.5347646526;40122.79938600288;40269.79865100656;41270.1745965079;42424.1515169701;42848.14303713908;6490.740370385131;6632.966835165793;6633.867322653424;6652.301508341555;6652.501062420241;28672.426551468438;29829.403411932075;31759.682403175673;32444.83777581097;32685.673143268265;36702;37710.62289377181;37729;41748.3737743928;42779.786101069294;6424.775132870327;6566.409023187936;6581.3747693969;6656.500762442933;6931.549449285781;8545.42095460642;8624.913750862412;8668.349873759367;8951.686690966046;9920.553575088994;8806.295496360404;8842.734717958472;8896.377253592187;9113.498757568397;9220.907790922272;9007.909920900707;9165.220956218796;9227.492487913229;9385.671501497414;9460.195883349992;8859.822803544022;8890.777730556787;8895.288376929959;9040.728778136667;9121.407108537924;7707.460477766503;7773.3004029637605;7773.805654858447;8100.756977290691;8261.38039647041;7161.677724502306;7209.459290553124;7230.9638451807405;7544.170141284564;7549.471536992358 19:36:19 INFO - 2015-11-11 19:36:19,076 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:36:19 INFO - 2015-11-11 19:36:19,076 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:36:19 INFO - 2015-11-11 19:36:19,076 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,293 19:36:19 INFO - 2015-11-11 19:36:19,076 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:36:19 INFO - 2015-11-11 19:36:19,077 DEBUG : BROWSER_OUTPUT: __startTimestamp1447299379060__endTimestamp 19:36:19 INFO - 2015-11-11 19:36:19,077 DEBUG : BROWSER_OUTPUT: 19:36:19 INFO - 2015-11-11 19:36:19,077 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:36:19 INFO - 2015-11-11 19:36:19,077 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:36:19 INFO - 2015-11-11 19:36:19,077 DEBUG : BROWSER_OUTPUT: 19:36:19 INFO - 2015-11-11 19:36:19,078 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4650.01 Median:4778.55 stddev:613.98 (12.8%) stddev-sans-first:594.89 19:36:19 INFO - 2015-11-11 19:36:19,078 DEBUG : BROWSER_OUTPUT: Values: 2621.6 2698.4 2751.8 2766.8 2768.8 4691.9 4727.6 4738.5 4763.7 4792.4 4600.2 4612.8 4659.0 4699.4 4778.0 4305.2 4350.5 4397.6 4398.0 4427.1 216.8 4153.6 4441.5 4456.4 4544.6 4268.6 4296.5 4314.9 4349.0 4379.6 4337.2 4432.5 4441.0 4452.3 4484.7 4173.1 4385.6 4399.3 4438.9 4444.4 4356.4 4436.5 4505.4 4605.3 4637.4 4929.7 4935.7 4986.9 5002.7 5031.6 4738.5 4938.7 4953.3 5099.6 5139.2 4691.3 4720.5 4734.0 4776.3 4777.1 5070.4 5087.3 5144.9 5155.4 5166.0 4729.1 4908.1 4928.9 5009.4 5062.8 5022.7 5028.5 5087.9 5095.0 5110.6 4997.5 5002.1 5013.3 5026.0 5033.2 4627.6 4644.7 4924.6 4971.6 5034.9 3857.5 3890.2 3898.1 3926.1 3928.8 3452.1 3539.3 3549.6 3568.6 3593.3 4627.1 4662.9 4703.4 4729.6 4778.5 5102.4 5109.5 5117.1 5158.5 5200.1 4479.6 4587.0 4744.9 4799.0 4887.2 4451.4 4473.0 4491.4 4500.6 4526.8 4952.1 5214.3 5219.4 5246.6 5250.7 4790.3 4837.7 4966.1 5096.5 5118.2 5130.9 5235.5 5238.9 5248.9 5299.8 4896.3 4906.3 5004.2 5005.0 5055.1 4767.4 4841.5 5007.1 5080.8 5134.8 4859.5 4941.1 4965.9 4977.6 5014.2 4895.8 4915.4 4949.4 4963.1 5027.4 4648.9 4744.3 4752.3 4773.1 4804.0 4744.8 4804.4 4863.2 4918.3 4921.2 4686.0 4804.8 4838.8 4846.3 4875.3 19:36:19 INFO - 2015-11-11 19:36:19,078 DEBUG : BROWSER_OUTPUT: 19:36:19 INFO - 2015-11-11 19:36:19,078 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38378.07 Median:29941.78 stddev:62703.24 (209.4%) stddev-sans-first:62814.49 19:36:19 INFO - 2015-11-11 19:36:19,078 DEBUG : BROWSER_OUTPUT: Values: 456.2 461.8 476.8 490.0 501.6 30905.5 31581.5 31600.5 31771.7 31882.0 34647.0 35627.6 35710.6 36146.6 36734.0 7660.7 7830.6 7831.1 7832.5 7863.8 7652.7 7779.1 7786.1 7788.4 7792.6 7795.1 7902.1 7918.6 7956.6 8027.8 7812.4 7860.3 7863.4 7872.0 7961.7 7720.2 7757.6 7779.8 7795.5 7836.8 33474.0 33951.3 33987.7 34149.9 34206.7 2246.0 2381.7 2523.3 2538.9 2725.2 22972.7 23271.8 23272.5 23486.5 24212.8 1890.6 1939.4 1971.6 1976.4 2055.8 212176.0 214773.9 215016.0 215760.0 216057.0 42847.4 49592.3 49812.5 49830.0 50049.0 44360.6 50562.5 52342.2 52705.7 52918.0 14153.9 14339.5 14620.8 14651.0 14790.0 10895.1 10977.3 10993.7 10997.8 11015.6 16203.8 16425.8 16431.3 16671.5 16756.6 7284.5 7469.2 7481.8 7512.7 7531.2 761.4 859.7 886.9 905.5 937.2 24060.4 24062.2 24283.9 24361.6 24475.5 894.6 929.7 933.2 945.7 974.5 12648.2 12651.9 12689.3 12757.5 12777.6 257466.0 263729.0 263917.0 264454.0 265295.0 45963.5 47112.3 47163.0 47212.0 47331.0 1175.7 1197.7 1202.8 1208.3 1218.1 23906.4 24357.4 24397.9 24487.1 24606.9 40789.8 40871.8 41092.8 41137.6 41316.2 238059.0 240715.0 240985.0 241385.0 242212.0 26595.3 27010.9 27121.2 27131.3 27133.1 31642.0 32266.5 32869.0 33114.8 33128.5 26945.5 29820.9 29958.7 30108.2 32125.4 28985.9 29509.8 29818.3 29924.9 30238.2 27966.4 28856.3 29138.9 29301.1 29396.1 22743.9 25064.0 25353.2 26411.7 27050.3 19885.7 20283.2 20317.5 20559.4 20603.4 19:36:19 INFO - 2015-11-11 19:36:19,078 DEBUG : BROWSER_OUTPUT: 19:36:19 INFO - 2015-11-11 19:36:19,079 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22920.77 Median:21809.54 stddev:75546.57 (346.4%) stddev-sans-first:75739.37 19:36:19 INFO - 2015-11-11 19:36:19,080 DEBUG : BROWSER_OUTPUT: Values: 282.5 288.1 288.4 290.6 294.3 12901.2 14530.3 14822.5 14942.8 15220.4 15064.5 15213.3 15675.8 15688.9 15807.2 3986.9 4069.9 4140.5 4161.7 4593.4 4035.9 4091.5 4119.8 4127.2 4127.6 2910.7 3450.6 4060.4 4094.2 4107.2 4077.6 4113.1 4117.3 4119.6 4138.8 3466.8 3486.1 3497.4 3521.2 3530.3 11138.3 11361.7 11429.4 11533.7 11553.5 1630.9 1634.7 1647.7 1660.7 1689.1 7428.0 7727.3 7772.6 7832.0 7855.6 1303.3 1326.5 1345.8 1354.9 1361.8 49445.8 51244.0 51331.2 51730.7 52140.5 5436.3 5440.9 5544.3 5563.4 5621.4 6313.7 6332.4 6335.4 6410.0 6412.1 4474.7 4570.3 4648.0 4679.9 4694.1 4923.5 4956.7 4986.4 4993.4 5020.2 2467.2 2485.0 2515.8 2523.7 2524.8 868.5 884.4 889.3 891.5 935.2 359.1 374.5 379.2 384.9 386.4 8551.7 9986.0 10359.5 10438.4 10459.4 381.9 387.2 390.7 391.8 392.9 5397.5 5532.2 5578.2 5587.7 5649.6 447181.8 451700.0 468145.0 468694.0 468967.0 59903.4 61132.7 61772.4 62017.0 62432.1 426.9 427.2 429.2 429.9 431.9 9127.8 9350.6 9364.6 9385.0 9661.2 30541.4 30602.2 30696.8 30842.2 30892.2 42234.7 42253.6 42346.6 42987.8 43187.1 5195.8 5299.3 5313.6 5397.4 5427.1 10133.4 10230.7 10247.5 10359.2 10373.2 8633.2 8839.7 8890.7 8939.2 8982.8 7244.7 8421.6 8439.1 8484.0 8523.7 8643.2 8656.1 8804.0 8859.5 8914.7 5179.8 5191.5 5211.4 5258.2 5291.5 8439.7 8605.8 8681.3 8697.5 8715.3 19:36:19 INFO - 2015-11-11 19:36:19,080 DEBUG : BROWSER_OUTPUT: 19:36:19 INFO - 2015-11-11 19:36:19,080 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4773.74 Median:6026.68 stddev:2434.19 (40.4%) stddev-sans-first:2428.25 19:36:19 INFO - 2015-11-11 19:36:19,081 DEBUG : BROWSER_OUTPUT: Values: 1456.4 1481.2 1500.5 1500.9 1505.9 6046.7 6152.4 6255.4 6448.9 6489.9 6663.2 6745.8 6778.3 6794.2 6896.1 1889.6 1893.9 1926.0 1929.7 1956.9 1923.9 1950.9 1964.7 1981.9 1994.3 1934.3 1957.7 1959.0 1961.4 1977.5 1896.1 1938.1 1942.0 1969.0 1976.6 1895.3 1912.5 1934.1 1951.6 1961.8 6888.8 6898.0 6935.8 6990.5 7027.2 4111.0 4205.1 4216.3 4225.0 4294.2 2235.5 2292.5 2491.9 2597.8 2614.0 720.2 726.2 771.4 771.9 783.1 9151.4 9177.3 9187.6 9306.6 9323.9 3752.0 3765.1 3840.1 3879.3 3925.9 7872.0 7988.3 8075.6 8084.4 8150.2 4288.5 4292.3 4293.5 4299.1 4362.3 3882.3 3889.2 3927.1 3943.5 3957.0 3214.9 3285.6 3300.9 3318.8 3340.5 1072.9 1081.9 1087.5 1088.5 1088.5 1101.6 1103.4 1119.5 1122.3 1151.8 6314.8 6374.9 6406.0 6429.5 6480.5 990.6 1054.8 1062.5 1076.1 1089.6 5064.1 5139.8 5145.4 5151.3 5177.5 7295.6 7669.6 8039.7 8051.4 8062.7 7678.9 7760.4 7963.8 7999.6 8120.4 6269.3 6330.7 6424.4 6429.9 6485.9 6280.0 6343.2 6431.8 6434.7 6448.9 6921.4 7215.0 7241.6 7253.3 7267.5 7245.8 7320.5 7429.3 7456.4 7534.7 6064.5 6078.4 6098.5 6146.6 6174.8 6542.9 6546.4 6608.5 6674.1 6679.5 6187.8 6235.3 6259.2 6260.4 6307.5 5944.8 6006.6 6118.2 6152.4 6168.9 6201.6 6215.8 6262.7 6286.7 6319.5 5595.4 5629.6 5680.0 5697.2 5728.1 5725.7 5778.4 5779.3 5782.5 5786.3 19:36:19 INFO - 2015-11-11 19:36:19,082 DEBUG : BROWSER_OUTPUT: 19:36:19 INFO - 2015-11-11 19:36:19,082 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4691.10 Median:5368.76 stddev:1436.26 (26.8%) stddev-sans-first:1401.10 19:36:19 INFO - 2015-11-11 19:36:19,083 DEBUG : BROWSER_OUTPUT: Values: 251.3 258.8 266.9 268.3 280.7 5199.5 5274.7 5303.8 5303.8 5333.1 5268.0 5299.0 5304.5 5306.1 5329.7 4126.2 4166.1 4182.7 4199.9 4213.3 4161.9 4166.6 4179.4 4201.3 4205.6 4047.5 4074.0 4144.8 4167.7 4169.6 4192.7 4197.3 4216.9 4218.8 4228.7 3602.2 3610.5 3621.1 3630.4 3658.3 5021.8 5022.5 5112.2 5176.5 5325.5 4386.5 4429.8 4468.4 4511.2 4518.2 5383.1 5436.0 5500.0 5533.2 5557.5 3670.1 3673.4 3680.2 3689.2 3739.4 5717.2 5725.8 5728.5 5787.7 5813.9 3739.1 3740.6 3744.2 3765.0 3803.1 3805.5 3810.3 3813.1 3862.1 3879.7 4447.2 4449.0 4501.4 4509.7 4510.8 5458.9 5578.2 5621.8 5635.7 5645.6 1341.7 1386.3 1403.0 1407.7 1408.4 880.1 892.1 899.7 900.8 909.0 5327.3 5354.0 5366.6 5404.1 5426.3 5883.8 5891.1 5895.7 5914.5 5973.9 5304.0 5357.9 5360.0 5370.9 5400.3 3155.7 3204.5 3227.4 3235.9 3255.6 5838.3 5966.2 6011.4 6015.8 6043.8 5813.0 5882.3 5886.7 5893.9 5998.6 6027.2 6089.6 6143.6 6151.1 6194.1 5824.4 5855.2 5894.5 5934.5 5938.1 5549.4 5707.3 5724.5 5782.8 5792.9 6008.9 6018.8 6094.5 6100.9 6113.6 3754.0 3755.8 3811.6 3827.7 3864.4 5736.6 5826.9 5828.0 5836.6 5856.7 5455.8 5598.9 5668.8 5740.1 5774.9 5630.7 5653.7 5658.9 5662.5 5773.0 5509.4 5560.7 5566.6 5595.7 5644.2 5570.5 5588.1 5654.7 5663.2 5697.9 5492.8 5575.7 5584.6 5590.2 5594.2 19:36:19 INFO - 2015-11-11 19:36:19,083 DEBUG : BROWSER_OUTPUT: 19:36:19 INFO - 2015-11-11 19:36:19,084 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11658.44 Median:5817.10 stddev:14091.45 (242.2%) stddev-sans-first:14106.19 19:36:19 INFO - 2015-11-11 19:36:19,085 DEBUG : BROWSER_OUTPUT: Values: 527.8 529.0 537.7 640.9 669.1 11613.9 11885.6 11913.9 11915.9 11974.4 9653.6 11131.8 11286.4 11292.6 11380.4 756.2 769.3 773.5 774.9 777.0 775.6 783.8 789.2 791.7 796.8 821.3 824.4 824.4 830.6 832.2 773.9 799.3 805.7 815.9 816.9 602.9 603.3 603.4 604.2 604.3 11416.4 11752.6 11764.1 11790.9 11877.2 9851.2 9940.7 10155.0 10213.8 10319.0 7898.6 7910.4 8087.3 8142.3 8209.8 2801.9 2827.3 2922.0 2939.5 2972.9 41887.0 42588.0 42691.4 42723.0 43125.0 7687.4 7704.8 7787.9 7798.5 7943.2 16357.4 16527.8 16539.8 16557.7 16862.9 5715.2 5919.0 5934.6 6036.8 6188.2 3212.8 3315.3 3400.2 3405.6 3496.8 2492.3 2557.7 2558.3 2594.5 2600.6 409.2 410.6 411.4 419.4 421.2 379.8 448.8 462.0 475.4 534.9 5990.0 6188.9 6281.2 6335.8 6468.1 433.9 484.5 495.8 501.9 515.6 3090.8 3206.4 3241.1 3334.3 3406.6 49052.0 49383.0 49767.8 50112.0 50895.2 41960.2 42108.8 42999.1 45287.0 46523.5 40122.8 40269.8 41270.2 42424.2 42848.1 6490.7 6633.0 6633.9 6652.3 6652.5 28672.4 29829.4 31759.7 32444.8 32685.7 36702.0 37710.6 37729.0 41748.4 42779.8 6424.8 6566.4 6581.4 6656.5 6931.5 8545.4 8624.9 8668.3 8951.7 9920.6 8806.3 8842.7 8896.4 9113.5 9220.9 9007.9 9165.2 9227.5 9385.7 9460.2 8859.8 8890.8 8895.3 9040.7 9121.4 7707.5 7773.3 7773.8 8100.8 8261.4 7161.7 7209.5 7231.0 7544.2 7549.5 19:36:19 INFO - 2015-11-11 19:36:19,085 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:36:19 INFO - 2015-11-11 19:36:19,085 DEBUG : BROWSER_OUTPUT: 19:36:19 INFO - 2015-11-11 19:36:19,721 INFO : Browser exited with error code: 0 19:36:19 INFO - 2015-11-11 19:36:19,753 INFO : Completed test dromaeo_css (00:18:31) 19:36:19 INFO - 2015-11-11 19:36:19,753 INFO : Starting test kraken 19:36:19 INFO - 2015-11-11 19:36:19,753 DEBUG : operating with platform_type : mac_ 19:36:19 INFO - 2015-11-11 19:36:19,754 INFO : Initialising browser for kraken test... 19:36:19 INFO - 2015-11-11 19:36:19,769 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmptTVYDp/profile http://localhost:56412/getInfo.html 19:36:23 INFO - 2015-11-11 19:36:23,121 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:36:23 INFO - 2015-11-11 19:36:23,121 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:36:23 INFO - 2015-11-11 19:36:23,121 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:36:23 INFO - 2015-11-11 19:36:23,121 DEBUG : BROWSER_OUTPUT: __metrics 19:36:23 INFO - 2015-11-11 19:36:23,777 INFO : Browser initialized. 19:36:23 INFO - 2015-11-11 19:36:23,778 INFO : Running cycle 1/1 for kraken test... 19:36:23 INFO - 2015-11-11 19:36:23,778 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmptTVYDp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:36:36 INFO - 2015-11-11 19:36:36,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 240365568 19:36:36 INFO - 2015-11-11 19:36:36,158 DEBUG : BROWSER_OUTPUT: 19:36:39 INFO - 2015-11-11 19:36:39,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56412/tests/kraken/driver.html?testName=audio-beat-detection) 19:36:39 INFO - 2015-11-11 19:36:39,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 259715072 19:36:39 INFO - 2015-11-11 19:36:39,617 DEBUG : BROWSER_OUTPUT: 19:36:42 INFO - 2015-11-11 19:36:42,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56412/tests/kraken/driver.html?testName=audio-dft) 19:36:43 INFO - 2015-11-11 19:36:43,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 267714560 19:36:43 INFO - 2015-11-11 19:36:43,253 DEBUG : BROWSER_OUTPUT: 19:36:46 INFO - 2015-11-11 19:36:46,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56412/tests/kraken/driver.html?testName=audio-fft) 19:36:47 INFO - 2015-11-11 19:36:47,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 267038720 19:36:47 INFO - 2015-11-11 19:36:47,136 DEBUG : BROWSER_OUTPUT: 19:36:49 INFO - 2015-11-11 19:36:49,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56412/tests/kraken/driver.html?testName=audio-oscillator) 19:36:49 INFO - 2015-11-11 19:36:49,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 267206656 19:36:49 INFO - 2015-11-11 19:36:49,908 DEBUG : BROWSER_OUTPUT: 19:36:52 INFO - 2015-11-11 19:36:52,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56412/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:36:52 INFO - 2015-11-11 19:36:52,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 267767808 19:36:52 INFO - 2015-11-11 19:36:52,890 DEBUG : BROWSER_OUTPUT: 19:36:56 INFO - 2015-11-11 19:36:56,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56412/tests/kraken/driver.html?testName=imaging-darkroom) 19:36:56 INFO - 2015-11-11 19:36:56,967 DEBUG : BROWSER_OUTPUT: RSS: Main: 266952704 19:36:56 INFO - 2015-11-11 19:36:56,967 DEBUG : BROWSER_OUTPUT: 19:37:00 INFO - 2015-11-11 19:37:00,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56412/tests/kraken/driver.html?testName=imaging-desaturate) 19:37:01 INFO - 2015-11-11 19:37:01,165 DEBUG : BROWSER_OUTPUT: RSS: Main: 265728000 19:37:01 INFO - 2015-11-11 19:37:01,165 DEBUG : BROWSER_OUTPUT: 19:37:04 INFO - 2015-11-11 19:37:04,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56412/tests/kraken/driver.html?testName=json-parse-financial) 19:37:05 INFO - 2015-11-11 19:37:05,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 265867264 19:37:05 INFO - 2015-11-11 19:37:05,056 DEBUG : BROWSER_OUTPUT: 19:37:06 INFO - 2015-11-11 19:37:06,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56412/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:37:07 INFO - 2015-11-11 19:37:07,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 267829248 19:37:07 INFO - 2015-11-11 19:37:07,381 DEBUG : BROWSER_OUTPUT: 19:37:09 INFO - 2015-11-11 19:37:09,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56412/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:37:10 INFO - 2015-11-11 19:37:10,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 267771904 19:37:10 INFO - 2015-11-11 19:37:10,039 DEBUG : BROWSER_OUTPUT: 19:37:12 INFO - 2015-11-11 19:37:12,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56412/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:37:12 INFO - 2015-11-11 19:37:12,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 267780096 19:37:12 INFO - 2015-11-11 19:37:12,981 DEBUG : BROWSER_OUTPUT: 19:37:15 INFO - 2015-11-11 19:37:15,944 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:37:16 INFO - 2015-11-11 19:37:16,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 267776000 19:37:16 INFO - 2015-11-11 19:37:16,537 DEBUG : BROWSER_OUTPUT: 19:37:19 INFO - 2015-11-11 19:37:19,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:37:20 INFO - 2015-11-11 19:37:20,098 DEBUG : BROWSER_OUTPUT: RSS: Main: 268369920 19:37:20 INFO - 2015-11-11 19:37:20,098 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56412/tests/kraken/driver.html?testName=ai-astar) 19:37:22 INFO - 2015-11-11 19:37:22,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 267603968 19:37:22 INFO - 2015-11-11 19:37:22,257 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,257 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:37:22 INFO - 2015-11-11 19:37:22,257 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:37:22 INFO - 2015-11-11 19:37:22,257 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:37:22 INFO - 2015-11-11 19:37:22,257 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:37:22 INFO - 2015-11-11 19:37:22,257 DEBUG : BROWSER_OUTPUT: |0;ai-astar;125;122;135;133;135;143;128;126;133;134 19:37:22 INFO - 2015-11-11 19:37:22,257 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;188;164;184;195;158;181;183;158;198;158 19:37:22 INFO - 2015-11-11 19:37:22,257 DEBUG : BROWSER_OUTPUT: |2;audio-dft;194;214;207;201;195;193;203;202;206;202 19:37:22 INFO - 2015-11-11 19:37:22,257 DEBUG : BROWSER_OUTPUT: |3;audio-fft;83;91;99;146;80;84;84;86;113;79 19:37:22 INFO - 2015-11-11 19:37:22,257 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;101;105;150;105;109;109;147;108;109;153 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;143;143;150;150;143;150;143;143;150;143 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;155;157;157;156;156;158;151;158;157;156 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;124;128;127;132;133;128;128;131;127;127 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;75;75;79;79;79;79;87;78;77 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;78;83;85;85;83;85;84;86;84;85 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;101;106;107;106;108;107;109;108;113;110 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;159;166;159;158;159;161;163;154;152;163 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;171;191;193;191;183;170;189;192;196;173 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;79;86;87;88;89;88;88;87;91;89 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,754 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:37:22 INFO - 2015-11-11 19:37:22,258 DEBUG : BROWSER_OUTPUT: __startTimestamp1447299442254__endTimestamp 19:37:22 INFO - 2015-11-11 19:37:22,259 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,260 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:37:22 INFO - 2015-11-11 19:37:22,260 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:37:22 INFO - 2015-11-11 19:37:22,260 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,260 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:131.40 Median:133.50 stddev:6.17 (4.6%) stddev-sans-first:6.09 19:37:22 INFO - 2015-11-11 19:37:22,260 DEBUG : BROWSER_OUTPUT: Values: 125.0 122.0 135.0 133.0 135.0 143.0 128.0 126.0 133.0 134.0 19:37:22 INFO - 2015-11-11 19:37:22,261 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,261 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:176.70 Median:183.50 stddev:15.77 (8.6%) stddev-sans-first:16.19 19:37:22 INFO - 2015-11-11 19:37:22,261 DEBUG : BROWSER_OUTPUT: Values: 188.0 164.0 184.0 195.0 158.0 181.0 183.0 158.0 198.0 158.0 19:37:22 INFO - 2015-11-11 19:37:22,261 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,261 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:201.70 Median:202.50 stddev:6.50 (3.2%) stddev-sans-first:6.27 19:37:22 INFO - 2015-11-11 19:37:22,262 DEBUG : BROWSER_OUTPUT: Values: 194.0 214.0 207.0 201.0 195.0 193.0 203.0 202.0 206.0 202.0 19:37:22 INFO - 2015-11-11 19:37:22,262 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,262 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:94.50 Median:84.00 stddev:20.82 (24.8%) stddev-sans-first:21.67 19:37:22 INFO - 2015-11-11 19:37:22,262 DEBUG : BROWSER_OUTPUT: Values: 83.0 91.0 99.0 146.0 80.0 84.0 84.0 86.0 113.0 79.0 19:37:22 INFO - 2015-11-11 19:37:22,262 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,263 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:119.60 Median:109.00 stddev:21.17 (19.4%) stddev-sans-first:21.36 19:37:22 INFO - 2015-11-11 19:37:22,263 DEBUG : BROWSER_OUTPUT: Values: 101.0 105.0 150.0 105.0 109.0 109.0 147.0 108.0 109.0 153.0 19:37:22 INFO - 2015-11-11 19:37:22,263 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,263 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:145.80 Median:146.50 stddev:3.61 (2.5%) stddev-sans-first:3.69 19:37:22 INFO - 2015-11-11 19:37:22,263 DEBUG : BROWSER_OUTPUT: Values: 143.0 143.0 150.0 150.0 143.0 150.0 143.0 143.0 150.0 143.0 19:37:22 INFO - 2015-11-11 19:37:22,263 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,263 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:156.10 Median:157.00 stddev:2.02 (1.3%) stddev-sans-first:2.11 19:37:22 INFO - 2015-11-11 19:37:22,265 DEBUG : BROWSER_OUTPUT: Values: 155.0 157.0 157.0 156.0 156.0 158.0 151.0 158.0 157.0 156.0 19:37:22 INFO - 2015-11-11 19:37:22,265 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,265 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:128.50 Median:128.00 stddev:2.72 (2.1%) stddev-sans-first:2.35 19:37:22 INFO - 2015-11-11 19:37:22,265 DEBUG : BROWSER_OUTPUT: Values: 124.0 128.0 127.0 132.0 133.0 128.0 128.0 131.0 127.0 127.0 19:37:22 INFO - 2015-11-11 19:37:22,265 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,265 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:78.00 Median:79.00 stddev:3.94 (5.0%) stddev-sans-first:3.54 19:37:22 INFO - 2015-11-11 19:37:22,265 DEBUG : BROWSER_OUTPUT: Values: 72.0 75.0 75.0 79.0 79.0 79.0 79.0 87.0 78.0 77.0 19:37:22 INFO - 2015-11-11 19:37:22,266 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,266 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:83.80 Median:85.00 stddev:2.25 (2.6%) stddev-sans-first:1.01 19:37:22 INFO - 2015-11-11 19:37:22,266 DEBUG : BROWSER_OUTPUT: Values: 78.0 83.0 85.0 85.0 83.0 85.0 84.0 86.0 84.0 85.0 19:37:22 INFO - 2015-11-11 19:37:22,266 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,266 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:107.50 Median:108.00 stddev:3.10 (2.9%) stddev-sans-first:2.22 19:37:22 INFO - 2015-11-11 19:37:22,266 DEBUG : BROWSER_OUTPUT: Values: 101.0 106.0 107.0 106.0 108.0 107.0 109.0 108.0 113.0 110.0 19:37:22 INFO - 2015-11-11 19:37:22,266 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,267 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:159.40 Median:160.00 stddev:4.20 (2.6%) stddev-sans-first:4.45 19:37:22 INFO - 2015-11-11 19:37:22,267 DEBUG : BROWSER_OUTPUT: Values: 159.0 166.0 159.0 158.0 159.0 161.0 163.0 154.0 152.0 163.0 19:37:22 INFO - 2015-11-11 19:37:22,267 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,267 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.90 Median:191.00 stddev:9.95 (5.2%) stddev-sans-first:9.19 19:37:22 INFO - 2015-11-11 19:37:22,267 DEBUG : BROWSER_OUTPUT: Values: 171.0 191.0 193.0 191.0 183.0 170.0 189.0 192.0 196.0 173.0 19:37:22 INFO - 2015-11-11 19:37:22,267 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,267 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:87.20 Median:88.00 stddev:3.19 (3.6%) stddev-sans-first:1.45 19:37:22 INFO - 2015-11-11 19:37:22,267 DEBUG : BROWSER_OUTPUT: Values: 79.0 86.0 87.0 88.0 89.0 88.0 88.0 87.0 91.0 89.0 19:37:22 INFO - 2015-11-11 19:37:22,268 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:37:22 INFO - 2015-11-11 19:37:22,268 DEBUG : BROWSER_OUTPUT: 19:37:22 INFO - 2015-11-11 19:37:22,962 INFO : Browser exited with error code: 0 19:37:23 INFO - 2015-11-11 19:37:23,019 INFO : Completed test kraken (00:01:03) 19:37:23 INFO - 2015-11-11 19:37:23,019 INFO : Starting test v8_7 19:37:23 INFO - 2015-11-11 19:37:23,019 DEBUG : operating with platform_type : mac_ 19:37:23 INFO - 2015-11-11 19:37:23,020 INFO : Initialising browser for v8_7 test... 19:37:23 INFO - 2015-11-11 19:37:23,035 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpG4QWwm/profile http://localhost:56412/getInfo.html 19:37:26 INFO - 2015-11-11 19:37:26,323 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:37:26 INFO - 2015-11-11 19:37:26,323 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:37:26 INFO - 2015-11-11 19:37:26,323 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:37:26 INFO - 2015-11-11 19:37:26,323 DEBUG : BROWSER_OUTPUT: __metrics 19:37:27 INFO - 2015-11-11 19:37:27,027 INFO : Browser initialized. 19:37:27 INFO - 2015-11-11 19:37:27,028 INFO : Running cycle 1/1 for v8_7 test... 19:37:27 INFO - 2015-11-11 19:37:27,028 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/T/tmpG4QWwm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:37:39 INFO - 2015-11-11 19:37:39,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 240492544 19:37:39 INFO - 2015-11-11 19:37:39,365 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56412/tests/v8_7/run.html (next: http://localhost:56412/tests/v8_7/run.html) 19:38:02 INFO - 2015-11-11 19:38:02,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 260960256 19:38:02 INFO - 2015-11-11 19:38:02,295 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,295 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:38:02 INFO - 2015-11-11 19:38:02,295 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: |0;Richards;856.1643835616438 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;231.4814814814815 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: |2;Encrypt;367.5119441381845 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6816.326530612245 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1322.7513227513227 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: |5;Earley;914.0767824497258 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: |6;Boyer;15194.029850746268 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: |7;RegExp;36482.142857142855 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: |8;Splay;763.9419404125287 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6816.326530612245 19:38:02 INFO - 2015-11-11 19:38:02,296 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:38:02 INFO - 2015-11-11 19:38:02,297 DEBUG : BROWSER_OUTPUT: __startTimestamp1447299482289__endTimestamp 19:38:02 INFO - 2015-11-11 19:38:02,297 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,297 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:38:02 INFO - 2015-11-11 19:38:02,297 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:38:02 INFO - 2015-11-11 19:38:02,297 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,297 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:856.16 Median:856.16 stddev:0.00 (0.0%) 19:38:02 INFO - 2015-11-11 19:38:02,297 DEBUG : BROWSER_OUTPUT: Values: 856.2 19:38:02 INFO - 2015-11-11 19:38:02,297 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,297 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:231.48 Median:231.48 stddev:0.00 (0.0%) 19:38:02 INFO - 2015-11-11 19:38:02,297 DEBUG : BROWSER_OUTPUT: Values: 231.5 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:367.51 Median:367.51 stddev:0.00 (0.0%) 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: Values: 367.5 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6816.33 Median:6816.33 stddev:0.00 (0.0%) 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: Values: 6816.3 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1322.75 Median:1322.75 stddev:0.00 (0.0%) 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: Values: 1322.8 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:914.08 Median:914.08 stddev:0.00 (0.0%) 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: Values: 914.1 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,298 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15194.03 Median:15194.03 stddev:0.00 (0.0%) 19:38:02 INFO - 2015-11-11 19:38:02,299 DEBUG : BROWSER_OUTPUT: Values: 15194.0 19:38:02 INFO - 2015-11-11 19:38:02,299 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,299 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:36482.14 Median:36482.14 stddev:0.00 (0.0%) 19:38:02 INFO - 2015-11-11 19:38:02,299 DEBUG : BROWSER_OUTPUT: Values: 36482.1 19:38:02 INFO - 2015-11-11 19:38:02,299 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,299 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:763.94 Median:763.94 stddev:0.00 (0.0%) 19:38:02 INFO - 2015-11-11 19:38:02,299 DEBUG : BROWSER_OUTPUT: Values: 763.9 19:38:02 INFO - 2015-11-11 19:38:02,299 DEBUG : BROWSER_OUTPUT: 19:38:02 INFO - 2015-11-11 19:38:02,300 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6816.33 Median:6816.33 stddev:0.00 (0.0%) 19:38:02 INFO - 2015-11-11 19:38:02,300 DEBUG : BROWSER_OUTPUT: Values: 6816.3 19:38:02 INFO - 2015-11-11 19:38:02,300 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:38:02 INFO - 2015-11-11 19:38:02,300 DEBUG : BROWSER_OUTPUT: 19:38:03 INFO - 2015-11-11 19:38:03,014 INFO : Browser exited with error code: 0 19:38:03 INFO - 2015-11-11 19:38:03,037 INFO : Completed test v8_7 (00:00:40) 19:38:03 INFO - 2015-11-11 19:38:03,197 INFO : Completed test suite (00:20:14) 19:38:03 INFO - 2015-11-11 19:38:03,197 DEBUG : Working with test: dromaeo_css 19:38:03 INFO - 2015-11-11 19:38:03,197 DEBUG : Generating results file: dromaeo_css 19:38:03 INFO - 2015-11-11 19:38:03,198 DEBUG : Working with test: kraken 19:38:03 INFO - 2015-11-11 19:38:03,198 DEBUG : Generating results file: kraken 19:38:03 INFO - 2015-11-11 19:38:03,199 INFO : javascript benchmark 19:38:03 INFO - 2015-11-11 19:38:03,199 DEBUG : Working with test: v8_7 19:38:03 INFO - 2015-11-11 19:38:03,199 DEBUG : Generating results file: v8_7 19:38:03 INFO - 2015-11-11 19:38:03,199 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:38:03 INFO - 2015-11-11 19:38:03,257 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 19:38:03 INFO - 2015-11-11 19:38:03,257 DEBUG : process_Request line: dromaeo_css 5722.66 graph.html#tests=[[72,1,57]] 19:38:03 INFO - 2015-11-11 19:38:03,257 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:38:03 INFO - 2015-11-11 19:38:03,283 DEBUG : process_Request line: kraken 1855.10 graph.html#tests=[[232,1,57]] 19:38:03 INFO - 2015-11-11 19:38:03,283 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:38:03 INFO - 2015-11-11 19:38:03,317 DEBUG : process_Request line: v8_7 14342.24 graph.html#tests=[[230,1,57]] 19:38:03 INFO - 2015-11-11 19:38:03,318 INFO : javascript benchmark 19:38:03 INFO - 2015-11-11 19:38:03,320 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [282.48023636508844, 288.0752783564757, 288.37422792540184, 290.62944745449556, 294.3069072334652, 12901.22592644442, 14530.273486325681, 14822.481213157529, 14942.775858362133, 15220.391184352613, 15064.548063558083, 15213.315400806963, 15675.764863527056, 15688.921555392235, 15807.209639518036, 3986.8604598839047, 4069.9389509157386, 4140.544540100586, 4161.667066634662, 4593.448786145667, 4035.8587449439274, 4091.529474110486, 4119.814608342616, 4127.17456508698, 4127.587241275864, 2910.7089291070934, 3450.6031806342216, 4060.3909413587903, 4094.2220978014084, 4107.219628270634, 4077.55146933837, 4113.095119073799, 4117.341225403936, 4119.629233369011, 4138.772367519785, 3466.757326987112, 3486.0936156599214, 3497.405441075023, 3521.154922818531, 3530.3292374448774, 11138.27601205919, 11361.715957101138, 11429.428528573539, 11533.711657208552, 11553.53785848565, 1630.9102999335032, 1634.6648936967892, 1647.7281248593968, 1660.6512632347221, 1689.1300979995312, 7427.960085587968, 7727.343175830061, 7772.611369431563, 7832.020997375328, 7855.607219638995, 1303.3287856753684, 1326.515821725073, 1345.8384993800807, 1354.8916086713039, 1361.8297712785902, 49445.752771235915, 51244.0, 51331.23003154918, 51730.741346293406, 52140.47859521394, 5436.347638283352, 5440.863978400572, 5544.3346798383645, 5563.360213575491, 5621.437856214346, 6313.747450102036, 6332.398422149889, 6335.36646335372, 6410.038494225903, 6412.102305677209, 4474.6867719259335, 4570.291604801195, 4648.0, 4679.906401871944, 4694.084653492536, 4923.48303428142, 4956.677815941952, 4986.351774269322, 4993.350864387607, 5020.246962955513, 2467.198160597813, 2484.962725559118, 2515.811314151446, 2523.684539432571, 2524.835885667426, 868.4658934755206, 884.425123669607, 889.3374436045059, 891.5007595746403, 935.2424536125624, 359.1309032142222, 374.5262243262275, 379.2301627695782, 384.9364854798983, 386.36250187190797, 8551.700690475804, 9986.0, 10359.533820978075, 10438.425886576311, 10459.424731639832, 381.8625294893836, 387.1637263510803, 390.7225869632593, 391.8119302734646, 392.880171547675, 5397.514223719884, 5532.225488431623, 5578.163275508625, 5587.720613969285, 5649.604527683105, 447181.8204544847, 451700.0, 468145.0, 468694.0, 468967.0, 59903.400965989786, 61132.69433652803, 61772.38227617756, 62017.0, 62432.06351904725, 426.9231538323132, 427.20326590908354, 429.1781238927419, 429.8860801887502, 431.94168787213323, 9127.817443650956, 9350.625974960925, 9364.578593963424, 9384.95307523458, 9661.178799802095, 30541.389172215986, 30602.234944126576, 30696.84651576728, 30842.228944276572, 30892.22769430782, 42234.67709275896, 42253.57746422497, 42346.576534234264, 42987.78506107449, 43187.13625727405, 5195.818146364859, 5299.258103865539, 5313.601479888946, 5397.406285308692, 5427.1316589345515, 10133.442660653734, 10230.693079207636, 10247.487625618838, 10359.22305827081, 10373.170146388422, 8633.223009929137, 8839.734807955772, 8890.73327800167, 8939.195472407515, 8982.832231809823, 7244.710211591478, 8421.621027053674, 8439.071702112886, 8483.957580212307, 8523.701670441505, 8643.17889800468, 8656.091110433566, 8804.0, 8859.51272679983, 8914.73255802327, 5179.766910489112, 5191.532762051283, 5211.426743058337, 5258.237555554347, 5291.470852914832, 8439.70461033861, 8605.784855378666, 8681.305495560466, 8697.52163630981, 8715.34634902372], "dojo.html": [2621.5936529837877, 2698.365884017257, 2751.76609988151, 2766.847823369715, 2768.7784977201827, 4691.8592442226745, 4727.645426593006, 4738.47876733559, 4763.737994410306, 4792.400949881265, 4600.17196904557, 4612.8385506507275, 4658.953410465894, 4699.38907941968, 4777.976110119454, 4305.160493703729, 4350.456192975878, 4397.604215620593, 4397.956020439803, 4427.1367083418745, 216.7637081174607, 4153.646141118071, 4441.489228738704, 4456.353828694853, 4544.568266014723, 4268.637165840907, 4296.5273819879785, 4314.935275970847, 4349.0, 4379.627731642814, 4337.240982828024, 4432.490263619693, 4441.022974945507, 4452.332150177467, 4484.730916145042, 4173.144505376391, 4385.649148068179, 4399.252127138394, 4438.933415998763, 4444.422225110748, 4356.411884395629, 4436.534163912775, 4505.43682039745, 4605.286180642006, 4637.420322459692, 4929.65492415531, 4935.654354901301, 4986.850394488171, 5002.699838009695, 5031.572316353077, 4738.455077666078, 4938.678985865943, 4953.2570114483115, 5099.566536844372, 5139.15203991341, 4691.319758635013, 4720.527947205286, 4734.0, 4776.283557466373, 4777.140114779373, 5070.416902056237, 5087.3386459759995, 5144.948550514522, 5155.432902380735, 5166.044281807877, 4729.054189162112, 4908.067467181224, 4928.926066109011, 5009.373828271466, 5062.82280120194, 5022.723750193774, 5028.547430731252, 5087.949120508822, 5095.031943930641, 5110.565601923804, 4997.525235102659, 5002.1496345621335, 5013.323201367842, 5025.974870125626, 5033.1695270280725, 4627.583517483443, 4644.7213167210075, 4924.630652701062, 4971.6271279654175, 5034.874128146826, 3857.4792403025795, 3890.2025084857537, 3898.142408670088, 3926.0577461409057, 3928.842846286174, 3452.1197094741183, 3539.2744487380023, 3549.6095429502734, 3568.6074531801482, 3593.317269718745, 4627.1439783640135, 4662.860114196579, 4703.388559487314, 4729.5743383095, 4778.546038126373, 5102.36220472441, 5109.489051094935, 5117.104506711311, 5158.458361872024, 5200.115980283361, 4479.619232365286, 4587.0, 4744.881377965578, 4799.0, 4887.169181239198, 4451.354553589711, 4473.0, 4491.393661855673, 4500.617447516997, 4526.751028693454, 4952.133376659142, 5214.296070030573, 5219.42586315505, 5246.580273578104, 5250.65870718402, 4790.305405716082, 4837.733924634179, 4966.056449274626, 5096.541311282002, 5118.181091025418, 5130.948690513047, 5235.502627250406, 5238.921416178684, 5248.947510524846, 5299.7615107321035, 4896.338994235733, 4906.288588154769, 5004.2493625956395, 5005.024020316004, 5055.1153548128195, 4767.380240568704, 4841.491643377394, 5007.123753343078, 5080.847574572768, 5134.768935397841, 4859.4654587996, 4941.135301322326, 4965.925511117264, 4977.601791856715, 5014.222795466709, 4895.828645997373, 4915.3855768029, 4949.406071271471, 4963.10664080469, 5027.396712394536, 4648.860534183845, 4744.288356746378, 4752.310914917249, 4773.140834649657, 4804.039192161652, 4744.762761861962, 4804.447488538863, 4863.173260545645, 4918.336024636628, 4921.212605983025, 4686.039361930728, 4804.759762011955, 4838.806447742051, 4846.345743324606, 4875.268709693574], "mootools.html": [1456.4101538876755, 1481.1779462398365, 1500.5423345879503, 1500.9399624015034, 1505.8870584706146, 6046.727897244624, 6152.446279834814, 6255.405736455035, 6448.871022579546, 6489.935100648992, 6663.20041595008, 6745.76389826355, 6778.254392016875, 6794.150731158606, 6896.137982752156, 1889.5842914558775, 1893.8958357290344, 1926.0, 1929.7394851694983, 1956.9412917612424, 1923.8941858197793, 1950.9024548772575, 1964.6561851675972, 1981.9207231710714, 1994.341867183833, 1934.264979307861, 1957.725918371429, 1958.9902050489727, 1961.3723608445302, 1977.5352792093847, 1896.1183049881802, 1938.060040880179, 1942.0, 1968.980310196894, 1976.5849171673965, 1895.2987394663924, 1912.4931893048354, 1934.0813113770987, 1951.6487032334173, 1961.794011628787, 6888.793336199922, 6898.034275201476, 6935.757248496328, 6990.4757143214465, 7027.227005029443, 4110.979445102786, 4205.11692544566, 4216.325387937915, 4224.978875105605, 4294.227039132955, 2235.452314183019, 2292.5071109711325, 2491.9003239870385, 2597.7662010419153, 2613.973860261392, 720.1610124205295, 726.2374506767925, 771.4368510986955, 771.9498232614862, 783.0603276068683, 9151.405158664666, 9177.265818734551, 9187.632494700203, 9306.627734890664, 9323.906760932372, 3752.0432289765936, 3765.0963768695865, 3840.116773142193, 3879.301725689403, 3925.9018524536546, 7871.960640196762, 7988.320992715684, 8075.636596353178, 8084.3936704747375, 8150.184981501802, 4288.506821715543, 4292.334688123346, 4293.549177336397, 4299.118680670455, 4362.302031674917, 3882.3011857865854, 3889.1638297766117, 3927.1360300734364, 3943.546492153439, 3957.0, 3214.8714051438146, 3285.589301337333, 3300.85146168423, 3318.7720543399096, 3340.4822252550894, 1072.855164552791, 1081.864766904137, 1087.5486673030603, 1088.455772113943, 1088.4992903264429, 1101.6089288302537, 1103.426218366445, 1119.5242022140558, 1122.2873475343215, 1151.78691941991, 6314.810555683337, 6374.872502549923, 6406.039094135824, 6429.485641148697, 6480.4815614750705, 990.6186118344345, 1054.7890421915647, 1062.4953147255146, 1076.0530732954949, 1089.624079692505, 5064.088464076428, 5139.7687104080405, 5145.382554093533, 5151.330327057459, 5177.534021938043, 7295.635218239173, 7669.578173200416, 8039.718609848627, 8051.39614528901, 8062.717804876801, 7678.923210767933, 7760.417968652374, 7963.761087167394, 7999.600019998977, 8120.3503719702285, 6269.341719119518, 6330.651814150174, 6424.421802037839, 6429.903551446732, 6485.935140648533, 6280.0, 6343.207099112611, 6431.839204019937, 6434.678266086583, 6448.935510644834, 6921.377076063179, 7214.96392518034, 7241.637918104179, 7253.274672532704, 7267.491275610657, 7245.818854528468, 7320.524165929198, 7429.257074292527, 7456.366208872307, 7534.736284230025, 6064.545159113172, 6078.3921607838865, 6098.512119030555, 6146.631202127886, 6174.845628859135, 6542.869142617216, 6546.378094081055, 6608.471322294301, 6674.065630811788, 6679.4656427484715, 6187.84530386744, 6235.282942461675, 6259.217597800275, 6260.436560709558, 6307.495400367868, 5944.821655350346, 6006.639601623741, 6118.20463339763, 6152.384761523812, 6168.938310617016, 6201.627902325875, 6215.7873859579895, 6262.686865656608, 6286.654234017173, 6319.494440444845, 5595.412481689526, 5629.577781666309, 5680.034394152921, 5697.202391665087, 5728.140778883034, 5725.742341594721, 5778.393268706894, 5779.335376431596, 5782.508486778671, 5786.30564332266], "ext.html": [456.2130325189049, 461.7552697070554, 476.8068932082506, 490.0126245615084, 501.6338073206557, 30905.536416953735, 31581.526277105862, 31600.52599211008, 31771.68228317716, 31882.0, 34647.0, 35627.64372356276, 35710.64289357106, 36146.638533614656, 36734.0, 7660.693572257103, 7830.647620857075, 7831.138574756772, 7832.530048197098, 7863.8034049148655, 7652.732154374598, 7779.144294127642, 7786.065672119354, 7788.415868809833, 7792.571408572526, 7795.064592248938, 7902.130765615778, 7918.604069796516, 7956.562389068599, 8027.799305017363, 7812.414068944823, 7860.331871790904, 7863.410244231677, 7872.0, 7961.681532738741, 7720.15078341382, 7757.612119394064, 7779.7666070017995, 7795.493292935941, 7836.843263134762, 33474.0, 33951.32097358039, 33987.66012339894, 34149.90201175875, 34206.657933420596, 2245.955080898389, 2381.666566680666, 2523.2682522068576, 2538.923832285034, 2725.1824452664123, 22972.65541016886, 23271.767282327128, 23272.53454930909, 23486.530269394687, 24212.757872421225, 1890.6029733755927, 1939.3890924358782, 1971.5662554238045, 1976.4070778766313, 2055.804698553635, 212176.0, 214773.92613036992, 215016.0, 215760.0, 216057.0, 42847.35728964068, 49592.256116158285, 49812.50187498151, 49830.0, 50049.0, 44360.55639443629, 50562.494375056514, 52342.21486677703, 52705.73647131817, 52918.0, 14153.929230353782, 14339.494353092983, 14620.780688289684, 14651.0, 14790.0, 10895.128389728803, 10977.28647637901, 10993.670189894156, 10997.780044399067, 11015.614453494249, 16203.756943645854, 16425.83574164267, 16431.342746290255, 16671.49985500437, 16756.581085472717, 7284.453665975073, 7469.215732348134, 7481.812954676067, 7512.699492020367, 7531.209223031503, 761.3604572159413, 859.6518410043817, 886.902440731519, 905.5472263868066, 937.2314701944476, 24060.39849003789, 24062.15782447606, 24283.878580607336, 24361.63457548138, 24475.510489790104, 894.552723638181, 929.7350255177242, 933.2300851797295, 945.6926498887889, 974.5322245322285, 12648.177868438706, 12651.936740316423, 12689.302088385228, 12757.48970041188, 12777.616671499869, 257466.0, 263729.0, 263917.0, 264454.0, 265295.0, 45963.54036459592, 47112.29331560029, 47163.0, 47212.0, 47331.0, 1175.7178277213407, 1197.7484728207173, 1202.7834989701762, 1208.3354155214597, 1218.056006594896, 23906.425732923584, 24357.39106522351, 24397.878010609835, 24487.14294999738, 24606.876965615058, 40789.796051019555, 40871.79564102161, 41092.794536027126, 41137.58862411338, 41316.1736765269, 238059.0, 240715.0, 240985.0, 241385.0, 242212.0, 26595.33511662224, 27010.864945675145, 27121.1863644091, 27131.321716957234, 27133.0657054722, 31642.0, 32266.516002259516, 32869.0, 33114.834425827714, 33128.50307245441, 26945.461090778466, 29820.85089574538, 29958.70041299559, 30108.24729381783, 32125.357492849544, 28985.855070724512, 29509.786765993067, 29818.254543636584, 29924.85037574798, 30238.244043899078, 27966.44067118687, 28856.2785930345, 29138.854305728335, 29301.120966371043, 29396.118116455684, 22743.88628056849, 25064.0, 25353.239402817944, 26411.735882641697, 27050.32374190661, 19885.701714474584, 20283.188672452936, 20317.49206269855, 20559.38321850347, 20603.381898543066], "prototype.html": [251.28509390783222, 258.760646402078, 266.85323072310223, 268.26762937181496, 280.6632041550138, 5199.454057323978, 5274.73626318684, 5303.787848486056, 5303.814366497164, 5333.120035194198, 5268.025415298163, 5298.973505132479, 5304.496072873071, 5306.097963346231, 5329.653572517794, 4126.174765046988, 4166.10428757817, 4182.665386769067, 4199.895002624929, 4213.30480470722, 4161.854335098272, 4166.625003749662, 4179.3939878717565, 4201.306784380574, 4205.579442055785, 4047.534533528638, 4074.0, 4144.813483393239, 4167.666586673074, 4169.5830416958215, 4192.7484350938885, 4197.265478541243, 4216.936745948813, 4218.78906054696, 4228.746275223496, 3602.225521512887, 3610.494530765695, 3621.0947263184203, 3630.3828349180703, 3658.268346330718, 5021.799128034874, 5022.522860328299, 5112.207607820794, 5176.508231718019, 5325.547328477084, 4386.473623165209, 4429.778511074465, 4468.374427580141, 4511.1654343946475, 4518.231900576877, 5383.111786555253, 5435.972820135914, 5500.0, 5533.170024496318, 5557.527610153142, 3670.064133645903, 3673.3938900081453, 3680.2271522980204, 3689.2252626948375, 3739.364308067635, 5717.228174196472, 5725.799597014085, 5728.541716662657, 5787.73955172014, 5813.912791308091, 3739.08392443853, 3740.588535261119, 3744.1762812181278, 3765.0, 3803.1062700265416, 3805.4862593549515, 3810.314143454205, 3813.142043040349, 3862.1117143057254, 3879.689624830063, 4447.177272204653, 4448.955510444919, 4501.369808226851, 4509.729416235036, 4510.8421205257655, 5458.863528411822, 5578.163275508706, 5621.831345059655, 5635.6618602883955, 5645.604807663424, 1341.684704094537, 1386.3414877933103, 1403.0389183409397, 1407.6691977385306, 1408.4436647524376, 880.1330689271063, 892.0989800301742, 899.7435730816686, 900.7612982559627, 908.981820363589, 5327.307450031549, 5353.973230133903, 5366.6243362964215, 5404.054290499147, 5426.321709786277, 5883.794067207627, 5891.086881533369, 5895.67573783446, 5914.467697907209, 5973.910391344133, 5304.045271851104, 5357.919631205535, 5359.973200133974, 5370.892582148335, 5400.324959380077, 3155.684431556872, 3204.4872820348633, 3227.402930457873, 3235.919102022421, 3255.5930508686415, 5838.2702162229725, 5966.19456373384, 6011.368806275278, 6015.849603759941, 6043.7884674036195, 5813.0, 5882.264716910387, 5886.676232807151, 5893.852653683606, 5998.580099393001, 6027.21646185993, 6089.634621922699, 6143.600665956787, 6151.0773383992755, 6194.0708893666315, 5824.446677565625, 5855.209546711139, 5894.469497745224, 5934.465898069022, 5938.109283607493, 5549.389567147691, 5707.258056452801, 5724.484796368347, 5782.7686892523825, 5792.855178620568, 6008.939910600838, 6018.849528761816, 6094.512439004958, 6100.877982440237, 6113.633182009094, 3753.981230093832, 3755.75587586806, 3811.6378944000276, 3827.7129215308405, 3864.381698928158, 5736.627119237236, 5826.854328641818, 5828.038373668297, 5836.562257830765, 5856.736446859816, 5455.8363249102595, 5598.86002849932, 5668.773249069991, 5740.1102829061565, 5774.9133762994425, 5630.690312032878, 5653.660780353192, 5658.858528536654, 5662.490375866192, 5773.04744717117, 5509.449055094458, 5560.721963901708, 5566.638168519034, 5595.720213989202, 5644.238027866186, 5570.5265052470995, 5588.077967135378, 5654.745536450787, 5663.150527420755, 5697.857553561194, 5492.780288788564, 5575.721213939368, 5584.553235741212, 5590.189422533791, 5594.244776955059], "yui.html": [527.8390091022239, 528.9973550132249, 537.7230726176018, 640.894252448346, 669.0800149794034, 11613.941930290348, 11885.643430697071, 11913.880861191385, 11915.940420297897, 11974.401279936, 9653.565589548469, 11131.777364452726, 11286.435678216098, 11292.604758833442, 11380.374079425628, 756.247533703964, 769.29225112896, 773.4585789947059, 774.8798936164903, 777.0054330457024, 775.5579319787723, 783.7805414483925, 789.1831953927687, 791.70311133325, 796.8047828282079, 821.2731732416825, 824.3775949158407, 824.4229039672224, 830.6469750356105, 832.2094010689839, 773.9496932699357, 799.2526987266895, 805.697863301262, 815.8980127484065, 816.9019717633893, 602.8824379246049, 603.2790814976062, 603.4478452216217, 604.1692672575209, 604.3412680178626, 11416.372099534605, 11752.58865939688, 11764.058875289957, 11790.94104529472, 11877.22798018126, 9851.162651174658, 9940.701778946572, 10155.0, 10213.846792298122, 10319.0, 7898.60506974649, 7910.367170626336, 8087.312578430781, 8142.267195952333, 8209.83580328396, 2801.9159425217276, 2827.3497095668113, 2922.021122923823, 2939.4873126613707, 2972.8513574321196, 41887.0, 42588.0, 42691.359629605584, 42723.0, 43125.0, 7687.385009199251, 7704.768856934301, 7787.92212077872, 7798.543458810456, 7943.205679432011, 16357.427490037791, 16527.752083718755, 16539.84221104511, 16557.668846623, 16862.91568542174, 5715.228444159985, 5918.970405147947, 5934.584579079509, 6036.8188954331445, 6188.195534580565, 3212.8072315661134, 3315.336932613487, 3400.217949871494, 3405.5913290404815, 3496.790192588453, 2492.2772396004957, 2557.667503224606, 2558.270892795544, 2594.532984062849, 2600.557905156128, 409.1673444540346, 410.5894105894106, 411.36444193720774, 419.38141241668905, 421.1555830559708, 379.7884747654972, 448.7733694484265, 461.9974654998661, 475.3630135618219, 534.9117395629678, 5990.0, 6188.8762224755255, 6281.183446152062, 6335.841603959938, 6468.06213099098, 433.85682724700774, 484.4534047959852, 495.79176745766864, 501.8607760383908, 515.5875299760177, 3090.799098058619, 3206.3587282543585, 3241.092494101655, 3334.299797042648, 3406.608240052376, 49052.0, 49383.0, 49767.75116124396, 50112.0, 50895.23657145146, 41960.160796784505, 42108.789456052524, 42999.14001719948, 45287.0, 46523.5347646526, 40122.79938600288, 40269.79865100656, 41270.1745965079, 42424.1515169701, 42848.14303713908, 6490.740370385131, 6632.966835165793, 6633.867322653424, 6652.301508341555, 6652.501062420241, 28672.426551468438, 29829.403411932075, 31759.682403175673, 32444.83777581097, 32685.673143268265, 36702.0, 37710.62289377181, 37729.0, 41748.3737743928, 42779.786101069294, 6424.775132870327, 6566.409023187936, 6581.3747693969, 6656.500762442933, 6931.549449285781, 8545.42095460642, 8624.913750862412, 8668.349873759367, 8951.686690966046, 9920.553575088994, 8806.295496360404, 8842.734717958472, 8896.377253592187, 9113.498757568397, 9220.907790922272, 9007.909920900707, 9165.220956218796, 9227.492487913229, 9385.671501497414, 9460.195883349992, 8859.822803544022, 8890.777730556787, 8895.288376929959, 9040.728778136667, 9121.407108537924, 7707.460477766503, 7773.3004029637605, 7773.805654858447, 8100.756977290691, 8261.38039647041, 7161.677724502306, 7209.459290553124, 7230.9638451807405, 7544.170141284564, 7549.471536992358]}, "summary": {"lowerIsBetter": false, "suite": 5722.660807449032, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5738.014736954022, "unit": "ms", "value": 5738.014736954022}, "dojo.html": {"lowerIsBetter": false, "filtered": 4613.429403366161, "unit": "ms", "value": 4613.429403366161}, "mootools.html": {"lowerIsBetter": false, "filtered": 3936.6536713402174, "unit": "ms", "value": 3936.6536713402174}, "ext.html": {"lowerIsBetter": false, "filtered": 15468.538703985761, "unit": "ms", "value": 15468.538703985761}, "prototype.html": {"lowerIsBetter": false, "filtered": 4208.257536495327, "unit": "ms", "value": 4208.257536495327}, "yui.html": {"lowerIsBetter": false, "filtered": 5177.066337816173, "unit": "ms", "value": 5177.066337816173}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0003.e"}, "testrun": {"date": 1447298268, "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": "20151111170847", "branch": "Firefox", "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a"}}, {"talos_counters": {}, "results": {"audio-dft": [194.0, 214.0, 207.0, 201.0, 195.0, 193.0, 203.0, 202.0, 206.0, 202.0], "ai-astar": [125.0, 122.0, 135.0, 133.0, 135.0, 143.0, 128.0, 126.0, 133.0, 134.0], "imaging-gaussian-blur": [143.0, 143.0, 150.0, 150.0, 143.0, 150.0, 143.0, 143.0, 150.0, 143.0], "audio-beat-detection": [188.0, 164.0, 184.0, 195.0, 158.0, 181.0, 183.0, 158.0, 198.0, 158.0], "json-stringify-tinderbox": [78.0, 83.0, 85.0, 85.0, 83.0, 85.0, 84.0, 86.0, 84.0, 85.0], "stanford-crypto-pbkdf2": [171.0, 191.0, 193.0, 191.0, 183.0, 170.0, 189.0, 192.0, 196.0, 173.0], "json-parse-financial": [72.0, 75.0, 75.0, 79.0, 79.0, 79.0, 79.0, 87.0, 78.0, 77.0], "stanford-crypto-sha256-iterative": [79.0, 86.0, 87.0, 88.0, 89.0, 88.0, 88.0, 87.0, 91.0, 89.0], "audio-fft": [83.0, 91.0, 99.0, 146.0, 80.0, 84.0, 84.0, 86.0, 113.0, 79.0], "imaging-darkroom": [155.0, 157.0, 157.0, 156.0, 156.0, 158.0, 151.0, 158.0, 157.0, 156.0], "stanford-crypto-ccm": [159.0, 166.0, 159.0, 158.0, 159.0, 161.0, 163.0, 154.0, 152.0, 163.0], "audio-oscillator": [101.0, 105.0, 150.0, 105.0, 109.0, 109.0, 147.0, 108.0, 109.0, 153.0], "stanford-crypto-aes": [101.0, 106.0, 107.0, 106.0, 108.0, 107.0, 109.0, 108.0, 113.0, 110.0], "imaging-desaturate": [124.0, 128.0, 127.0, 132.0, 133.0, 128.0, 128.0, 131.0, 127.0, 127.0]}, "summary": {"lowerIsBetter": true, "suite": 1855.1000000000001, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 94.5, "unit": "ms", "value": 94.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 184.9, "unit": "ms", "value": 184.9}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 176.7, "unit": "ms", "value": 176.7}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 159.4, "unit": "ms", "value": 159.4}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 156.1, "unit": "ms", "value": 156.1}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 78.0, "unit": "ms", "value": 78.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 119.6, "unit": "ms", "value": 119.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 131.4, "unit": "ms", "value": 131.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 201.7, "unit": "ms", "value": 201.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 87.2, "unit": "ms", "value": 87.2}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 83.8, "unit": "ms", "value": 83.8}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 145.8, "unit": "ms", "value": 145.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 107.5, "unit": "ms", "value": 107.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 128.5, "unit": "ms", "value": 128.5}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0003.e"}, "testrun": {"date": 1447298268, "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": "20151111170847", "branch": "Firefox", "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a"}}, {"talos_counters": {}, "results": {"DeltaBlue": [231.4814814814815], "Encrypt": [367.5119441381845], "NavierStokes": [6816.326530612245], "Decrypt": [6816.326530612245], "Splay": [763.9419404125287], "Richards": [856.1643835616438], "RegExp": [36482.142857142855], "Earley": [914.0767824497258], "Boyer": [15194.029850746268], "RayTrace": [1322.7513227513227]}, "summary": {"lowerIsBetter": false, "suite": 14342.243923135691, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 285.6297599999999, "unit": "score", "value": 285.6297599999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 724.2785010000003, "unit": "score", "value": 724.2785010000003}, "NavierStokes": {"lowerIsBetter": false, "filtered": 217.7125748502992, "unit": "score", "value": 217.7125748502992}, "Decrypt": {"lowerIsBetter": false, "filtered": 39.050505988023914, "unit": "score", "value": 39.050505988023914}, "Splay": {"lowerIsBetter": false, "filtered": 106.671719, "unit": "score", "value": 106.671719}, "RegExp": {"lowerIsBetter": false, "filtered": 24.97070974057759, "unit": "score", "value": 24.97070974057759}, "Richards": {"lowerIsBetter": false, "filtered": 41.23273600000001, "unit": "score", "value": 41.23273600000001}, "Earley": {"lowerIsBetter": false, "filtered": 729.110522, "unit": "score", "value": 729.110522}, "Boyer": {"lowerIsBetter": false, "filtered": 43.86347838899805, "unit": "score", "value": 43.86347838899805}, "RayTrace": {"lowerIsBetter": false, "filtered": 559.4316839999998, "unit": "score", "value": 559.4316839999998}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0003.e"}, "testrun": {"date": 1447298268, "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": "20151111170847", "branch": "Firefox", "revision": "a8ed7dd831d1969a5a1a8636e63bd93d6aeaf94a"}}] 19:38:03 INFO - RETURN: dromaeo_css: 5722.66 19:38:03 INFO - RETURN: kraken: 1855.10 19:38:03 INFO - RETURN: v8_7: 14342.24 19:38:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "14342.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1855.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "5722.66"}}} 19:38:03 INFO - Return code: 0 19:38:03 INFO - # TBPL SUCCESS # 19:38:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:38:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:38:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:38:03 INFO - 2015-11-11 19:38:03.427 screenresolution[1949:20581] starting screenresolution argv=screenresolution get 19:38:03 INFO - 2015-11-11 19:38:03.433 screenresolution[1949:20581] Display 0: 1600x1200x32@60 19:38:03 INFO - 2015-11-11 19:38:03.440 screenresolution[1950:20585] starting screenresolution argv=screenresolution list 19:38:03 INFO - Available Modes on Display 0 19:38:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:38:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:38:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:38:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:38:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:38:03 INFO - Intel HD Graphics 3000: 19:38:03 INFO - Chipset Model: Intel HD Graphics 3000 19:38:03 INFO - Type: GPU 19:38:03 INFO - Bus: Built-In 19:38:03 INFO - VRAM (Total): 512 MB 19:38:03 INFO - VRAM (Dynamic, Max): 10 19:38:03 INFO - Vendor: Intel (0x8086) 19:38:03 INFO - Device ID: 0x0116 19:38:03 INFO - Revision ID: 0x0009 19:38:03 INFO - Displays: 19:38:03 INFO - Display: 19:38:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:38:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:38:03 INFO - Display Serial Number: 1600x1200 60 19:38:03 INFO - Main Display: Yes 19:38:03 INFO - Mirror: Off 19:38:03 INFO - Online: Yes 19:38:03 INFO - Rotation: Supported 19:38:03 INFO - Return code: 0 19:38:03 INFO - Running post-action listener: _resource_record_post_action 19:38:03 INFO - Running post-run listener: _resource_record_post_run 19:38:04 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 3698688; Write bytes: 690152448; Read time: 276; Write time: 69691 19:38:04 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 338610688; Write bytes: 334665728; Read time: 36344; Write time: 6375 19:38:04 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 3698688; Write bytes: 344239104; Read time: 276; Write time: 62390 19:38:04 INFO - Running post-run listener: _upload_blobber_files 19:38:04 INFO - Blob upload gear active. 19:38:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:38:04 INFO - Copying logs to upload dir... 19:38:04 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1313.015496 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2015-11-11 19:38:04.885626) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 19:38:04.889740) ========= 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.7mOQ80Zb78/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.AApojZZoBu/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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/0p6A6oSaSzSFE5805Iut6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010893 build_url: 'https://queue.taskcluster.net/v1/task/0p6A6oSaSzSFE5805Iut6Q/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-11 19:38:04.918694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:38:04.919216) ========= 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.7mOQ80Zb78/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.AApojZZoBu/Listeners TMPDIR=/var/folders/cw/_xv6mg8d0t702jwwbvcr0zmc00000w/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.005545 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:38:04.972884) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 19:38:04.973665) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 19:38:04.974662) ========= ========= Total master_lag: 0.29 =========