builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0013 starttime: 1448066318.55 results: success (0) buildid: 20151120143736 builduid: f2d2bb58af1b4b6bb0dbb6ee76ec236e revision: e3d9cf3dc32654aaccbb9ff95930521d2b87a151 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.553069) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.553537) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.553851) ========= 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.1wBvGe8y4P/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.T2HzdeTmTs/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005256 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.574873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.575189) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.591104) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.591550) ========= 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.1wBvGe8y4P/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.T2HzdeTmTs/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005789 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.640492) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.640828) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.641232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.641527) ========= 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.1wBvGe8y4P/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.T2HzdeTmTs/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:0:0 using PTY: False --2015-11-20 16:38:38-- 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% 8.53M=0.001s 2015-11-20 16:38:38 (8.53 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.201988 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.885795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.886105) ========= 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.1wBvGe8y4P/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.T2HzdeTmTs/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026103 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:38.934817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 16:38:38.935129) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e3d9cf3dc32654aaccbb9ff95930521d2b87a151 --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 e3d9cf3dc32654aaccbb9ff95930521d2b87a151 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1wBvGe8y4P/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.T2HzdeTmTs/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:0:0 using PTY: False 2015-11-20 16:38:39,016 truncating revision to first 12 chars 2015-11-20 16:38:39,016 Setting DEBUG logging. 2015-11-20 16:38:39,016 attempt 1/10 2015-11-20 16:38:39,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e3d9cf3dc326?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 16:38:40,239 unpacking tar archive at: mozilla-central-e3d9cf3dc326/testing/mozharness/ program finished with exit code 0 elapsedTime=1.460024 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 16:38:40.410059) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:40.410526) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:40.422128) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:40.422524) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:38:40.423082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-20 16:38:40.423404) ========= /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.1wBvGe8y4P/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.T2HzdeTmTs/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:0:0 using PTY: False 16:38:40 INFO - MultiFileLogger online at 20151120 16:38:40 in /builds/slave/test 16:38:40 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 16:38:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:38:40 INFO - {'append_to_log': False, 16:38:40 INFO - 'base_work_dir': '/builds/slave/test', 16:38:40 INFO - 'blob_upload_branch': 'Firefox', 16:38:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:38:40 INFO - 'branch': 'Firefox', 16:38:40 INFO - 'buildbot_json_path': 'buildprops.json', 16:38:40 INFO - 'config_files': ('talos/mac_config.py',), 16:38:40 INFO - 'default_actions': ('clobber', 16:38:40 INFO - 'read-buildbot-config', 16:38:40 INFO - 'download-and-extract', 16:38:40 INFO - 'populate-webroot', 16:38:40 INFO - 'create-virtualenv', 16:38:40 INFO - 'install', 16:38:40 INFO - 'run-tests'), 16:38:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:38:40 INFO - 'download_minidump_stackwalk': True, 16:38:40 INFO - 'download_symbols': 'ondemand', 16:38:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:38:40 INFO - 'tooltool.py': '/tools/tooltool.py', 16:38:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:38:40 INFO - '/tools/misc-python/virtualenv.py')}, 16:38:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:38:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:38:40 INFO - 'installer_path': 'installer.exe', 16:38:40 INFO - 'log_level': 'info', 16:38:40 INFO - 'log_name': 'talos', 16:38:40 INFO - 'log_to_console': True, 16:38:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:38:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:38:40 INFO - 'opt_config_files': (), 16:38:40 INFO - 'pip_index': False, 16:38:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:38:40 INFO - 'cmd': ('bash', 16:38:40 INFO - '-c', 16:38:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:38:40 INFO - 'enabled': True, 16:38:40 INFO - 'halt_on_failure': False, 16:38:40 INFO - 'name': 'check_screen_resolution'},), 16:38:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:38:40 INFO - 'cmd': ('bash', 16:38:40 INFO - '-c', 16:38:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:38:40 INFO - 'enabled': True, 16:38:40 INFO - 'halt_on_failure': False, 16:38:40 INFO - 'name': 'check_screen_resolution'},), 16:38:40 INFO - 'run_cmd_checks_enabled': True, 16:38:40 INFO - 'sps_profile': False, 16:38:40 INFO - 'sps_profile_interval': 0, 16:38:40 INFO - 'suite': 'dromaeojs-e10s', 16:38:40 INFO - 'system_bits': '64', 16:38:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:38:40 INFO - 'title': 't-yosemite-r7-0013', 16:38:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:38:40 INFO - 'use_talos_json': True, 16:38:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:38:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:38:40 INFO - 'work_dir': 'build'} 16:38:40 INFO - ##### 16:38:40 INFO - ##### Running clobber step. 16:38:40 INFO - ##### 16:38:40 INFO - Running pre-action listener: _resource_record_pre_action 16:38:40 INFO - Running main action method: clobber 16:38:40 INFO - rmtree: /builds/slave/test/build 16:38:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:38:42 INFO - Running post-action listener: _resource_record_post_action 16:38:42 INFO - ##### 16:38:42 INFO - ##### Running read-buildbot-config step. 16:38:42 INFO - ##### 16:38:42 INFO - Running pre-action listener: _resource_record_pre_action 16:38:42 INFO - Running main action method: read_buildbot_config 16:38:42 INFO - Using buildbot properties: 16:38:42 INFO - { 16:38:42 INFO - "properties": { 16:38:42 INFO - "buildnumber": 5, 16:38:42 INFO - "product": "firefox", 16:38:42 INFO - "script_repo_revision": "production", 16:38:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 16:38:42 INFO - "repository": "", 16:38:42 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 16:38:42 INFO - "buildid": "20151120143736", 16:38:42 INFO - "slavename": "t-yosemite-r7-0013", 16:38:42 INFO - "pgo_build": "False", 16:38:42 INFO - "basedir": "/builds/slave/test", 16:38:42 INFO - "project": "", 16:38:42 INFO - "platform": "yosemite_r7", 16:38:42 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:38:42 INFO - "slavebuilddir": "test", 16:38:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:38:42 INFO - "branch": "mozilla-central", 16:38:42 INFO - "repo_path": "mozilla-central", 16:38:42 INFO - "stage_platform": "macosx64", 16:38:42 INFO - "builduid": "f2d2bb58af1b4b6bb0dbb6ee76ec236e", 16:38:42 INFO - "revision": "e3d9cf3dc32654aaccbb9ff95930521d2b87a151" 16:38:42 INFO - }, 16:38:42 INFO - "sourcestamp": { 16:38:42 INFO - "repository": "", 16:38:42 INFO - "hasPatch": false, 16:38:42 INFO - "project": "", 16:38:42 INFO - "branch": "mozilla-central-macosx64-talos", 16:38:42 INFO - "changes": [ 16:38:42 INFO - { 16:38:42 INFO - "category": null, 16:38:42 INFO - "files": [ 16:38:42 INFO - { 16:38:42 INFO - "url": null, 16:38:42 INFO - "name": "https://queue.taskcluster.net/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:38:42 INFO - } 16:38:42 INFO - ], 16:38:42 INFO - "repository": "", 16:38:42 INFO - "rev": "e3d9cf3dc32654aaccbb9ff95930521d2b87a151", 16:38:42 INFO - "who": "kwierso@gmail.com", 16:38:42 INFO - "when": 1448065552, 16:38:42 INFO - "number": 6691377, 16:38:42 INFO - "comments": "Merge inbound to central, a=merge", 16:38:42 INFO - "project": "", 16:38:42 INFO - "at": "Fri 20 Nov 2015 16:25:52", 16:38:42 INFO - "branch": "mozilla-central-macosx64-talos", 16:38:42 INFO - "revlink": "", 16:38:42 INFO - "properties": [ 16:38:42 INFO - [ 16:38:42 INFO - "buildid", 16:38:42 INFO - "20151120143736", 16:38:42 INFO - "Change" 16:38:42 INFO - ], 16:38:42 INFO - [ 16:38:42 INFO - "builduid", 16:38:42 INFO - "f2d2bb58af1b4b6bb0dbb6ee76ec236e", 16:38:42 INFO - "Change" 16:38:42 INFO - ], 16:38:42 INFO - [ 16:38:42 INFO - "pgo_build", 16:38:42 INFO - "False", 16:38:42 INFO - "Change" 16:38:42 INFO - ] 16:38:42 INFO - ], 16:38:42 INFO - "revision": "e3d9cf3dc32654aaccbb9ff95930521d2b87a151" 16:38:42 INFO - } 16:38:42 INFO - ], 16:38:42 INFO - "revision": "e3d9cf3dc32654aaccbb9ff95930521d2b87a151" 16:38:42 INFO - } 16:38:42 INFO - } 16:38:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:38:42 INFO - Running post-action listener: _resource_record_post_action 16:38:42 INFO - ##### 16:38:42 INFO - ##### Running download-and-extract step. 16:38:42 INFO - ##### 16:38:42 INFO - Running pre-action listener: _resource_record_pre_action 16:38:42 INFO - Running main action method: download_and_extract 16:38:42 INFO - mkdir: /builds/slave/test/build/tests 16:38:42 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')]} 16:38:42 INFO - https://queue.taskcluster.net/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:38:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/test_packages.json 16:38:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/test_packages.json 16:38:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:38:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:38:44 INFO - Downloaded 1149 bytes. 16:38:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:38:44 INFO - Using the following test package requirements: 16:38:44 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:38:44 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:38:44 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:38:44 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:38:44 INFO - u'jsshell-mac.zip'], 16:38:44 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:38:44 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:38:44 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:38:44 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:38:44 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:38:44 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:38:44 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:38:44 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:38:44 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:38:44 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:38:44 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:38:44 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:38:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:38: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')]} 16:38:44 INFO - https://queue.taskcluster.net/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:38:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:38:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:38:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/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 16:38:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/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 16:38:45 INFO - Downloaded 17524517 bytes. 16:38:45 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 16:38:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:38:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:38:48 INFO - Return code: 0 16:38:48 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 16:38:48 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')]} 16:38:48 INFO - https://queue.taskcluster.net/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:38:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:38:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:38:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/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 16:38:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/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 16:38:49 INFO - Downloaded 17524517 bytes. 16:38:49 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 16:38:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:38:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:38:52 INFO - Return code: 0 16:38:52 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')]} 16:38:52 INFO - https://queue.taskcluster.net/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:38:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:38:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:38:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/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 16:38:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/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 16:38:53 INFO - Downloaded 11130997 bytes. 16:38:53 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 16:38:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:38:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:38:53 INFO - Return code: 0 16:38: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')]} 16:38:53 INFO - https://queue.taskcluster.net/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:38:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:38:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:38:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:38:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/06ymnJYlSiKZwjG0fGSv8A/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 16:38:56 INFO - Downloaded 109638184 bytes. 16:38:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:38:56 INFO - mkdir: /builds/slave/test/properties 16:38:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:38:56 INFO - Writing to file /builds/slave/test/properties/build_url 16:38:56 INFO - Contents: 16:38:56 INFO - build_url:https://queue.taskcluster.net/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:38:56 INFO - Running post-action listener: _resource_record_post_action 16:38:56 INFO - Running post-action listener: set_extra_try_arguments 16:38:56 INFO - ##### 16:38:56 INFO - ##### Running populate-webroot step. 16:38:56 INFO - ##### 16:38:56 INFO - Running pre-action listener: _resource_record_pre_action 16:38:56 INFO - Running main action method: populate_webroot 16:38:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:38:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:38:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:38:56 INFO - '../fennec_ids.txt'], 16:38:56 INFO - 'tests': ['tcheck2']}, 16:38:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:38:56 INFO - '--tppagecycles', 16:38:56 INFO - '7'], 16:38:56 INFO - 'tests': ['tsvgm']}}, 16:38:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:38:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:38:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:38:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:38:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:38:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:38:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:56 INFO - 'talos_options': ['--e10s'], 16:38:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:56 INFO - 'tests': ['damp', 'tps']}, 16:38:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:56 INFO - 'talos_options': ['--e10s'], 16:38:56 INFO - 'tests': ['damp', 'tps']}, 16:38:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:38:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:38:56 INFO - 'other': {'tests': ['a11yr', 16:38:56 INFO - 'ts_paint', 16:38:56 INFO - 'tpaint', 16:38:56 INFO - 'sessionrestore', 16:38:56 INFO - 'sessionrestore_no_auto_restore']}, 16:38:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:38:56 INFO - 'tests': ['a11yr', 16:38:56 INFO - 'ts_paint', 16:38:56 INFO - 'tpaint', 16:38:56 INFO - 'sessionrestore', 16:38:56 INFO - 'sessionrestore_no_auto_restore']}, 16:38:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:38:56 INFO - 'tests': ['a11yr', 16:38:56 INFO - 'ts_paint', 16:38:56 INFO - 'tpaint', 16:38:56 INFO - 'sessionrestore', 16:38:56 INFO - 'sessionrestore_no_auto_restore']}, 16:38:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:38:56 INFO - 'tests': ['a11yr', 16:38:56 INFO - 'ts_paint', 16:38:56 INFO - 'tpaint', 16:38:56 INFO - 'sessionrestore', 16:38:56 INFO - 'sessionrestore_no_auto_restore']}, 16:38:56 INFO - 'other_l64': {'tests': ['a11yr', 16:38:56 INFO - 'ts_paint', 16:38:56 INFO - 'tpaint', 16:38:56 INFO - 'sessionrestore', 16:38:56 INFO - 'sessionrestore_no_auto_restore']}, 16:38:56 INFO - 'other_nol64': {'tests': ['a11yr', 16:38:56 INFO - 'ts_paint', 16:38:56 INFO - 'tpaint', 16:38:56 INFO - 'sessionrestore', 16:38:56 INFO - 'sessionrestore_no_auto_restore']}, 16:38:56 INFO - 'svgr': {'tests': ['tsvgx', 16:38:56 INFO - 'tsvgr_opacity', 16:38:56 INFO - 'tart', 16:38:56 INFO - 'tscrollx', 16:38:56 INFO - 'cart']}, 16:38:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:38:56 INFO - 'tests': ['tsvgx', 16:38:56 INFO - 'tsvgr_opacity', 16:38:56 INFO - 'tart', 16:38:56 INFO - 'tscrollx', 16:38:56 INFO - 'cart']}, 16:38:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:56 INFO - 'tests': ['tp5o']}, 16:38:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:56 INFO - 'talos_options': ['--e10s'], 16:38:56 INFO - 'tests': ['tp5o']}, 16:38:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:56 INFO - 'talos_options': ['--xperf_path', 16:38:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:56 INFO - 'tests': ['tp5n']}, 16:38:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:38:56 INFO - 'talos_options': ['--e10s', 16:38:56 INFO - '--xperf_path', 16:38:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:56 INFO - 'tests': ['tp5n']}}, 16:38:56 INFO - 'talos.zip': {'path': '', 16:38:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:38:56 INFO - Running post-action listener: _resource_record_post_action 16:38:56 INFO - ##### 16:38:56 INFO - ##### Running create-virtualenv step. 16:38:56 INFO - ##### 16:38:56 INFO - Running pre-action listener: _resource_record_pre_action 16:38:56 INFO - Running main action method: create_virtualenv 16:38:56 INFO - Creating virtualenv /builds/slave/test/build/venv 16:38:56 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 16:38:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:38:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:38:56 INFO - Using real prefix '/tools/python27' 16:38:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:38:57 INFO - Installing distribute.............................................................................................................................................................................................done. 16:39:00 INFO - Installing pip.................done. 16:39:00 INFO - Return code: 0 16:39:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110409490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe468ccb8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032d9f0>, '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 0x11008cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103208c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/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.T2HzdeTmTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/Render', 16:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:00 INFO - 'HOME': '/Users/cltbld', 16:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:00 INFO - 'LOGNAME': 'cltbld', 16:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:00 INFO - 'MOZ_NO_REMOTE': '1', 16:39:00 INFO - 'NO_EM_RESTART': '1', 16:39:00 INFO - 'PAGER': '/bin/cat', 16:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:00 INFO - 'PWD': '/builds/slave/test', 16:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:00 INFO - 'SHELL': '/bin/bash', 16:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T2HzdeTmTs/Listeners', 16:39:00 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 16:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:00 INFO - 'USER': 'cltbld', 16:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:00 INFO - 'XPC_FLAGS': '0x0', 16:39:00 INFO - 'XPC_SERVICE_NAME': '0', 16:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:39:00 INFO - Cleaning up... 16:39:00 INFO - Return code: 0 16:39:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110409490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe468ccb8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032d9f0>, '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 0x11008cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103208c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/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.T2HzdeTmTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/Render', 16:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:00 INFO - 'HOME': '/Users/cltbld', 16:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:00 INFO - 'LOGNAME': 'cltbld', 16:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:00 INFO - 'MOZ_NO_REMOTE': '1', 16:39:00 INFO - 'NO_EM_RESTART': '1', 16:39:00 INFO - 'PAGER': '/bin/cat', 16:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:00 INFO - 'PWD': '/builds/slave/test', 16:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:00 INFO - 'SHELL': '/bin/bash', 16:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T2HzdeTmTs/Listeners', 16:39:00 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 16:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:00 INFO - 'USER': 'cltbld', 16:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:00 INFO - 'XPC_FLAGS': '0x0', 16:39:00 INFO - 'XPC_SERVICE_NAME': '0', 16:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:00 INFO - Downloading/unpacking psutil>=0.7.1 16:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:39:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:39:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:39:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:03 INFO - Installing collected packages: psutil 16:39:03 INFO - Running setup.py install for psutil 16:39:03 INFO - building 'psutil._psutil_osx' extension 16:39:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:39:04 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 16:39:04 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 16:39:04 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 16:39:04 INFO - building 'psutil._psutil_posix' extension 16:39:04 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 16:39:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:39:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:39:04 INFO - ^ 16:39:04 INFO - 1 warning generated. 16:39:04 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 16:39:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:39:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:39:04 INFO - Successfully installed psutil 16:39:04 INFO - Cleaning up... 16:39:04 INFO - Return code: 0 16:39:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110409490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe468ccb8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032d9f0>, '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 0x11008cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103208c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/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.T2HzdeTmTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/Render', 16:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:04 INFO - 'HOME': '/Users/cltbld', 16:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:04 INFO - 'LOGNAME': 'cltbld', 16:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:04 INFO - 'MOZ_NO_REMOTE': '1', 16:39:04 INFO - 'NO_EM_RESTART': '1', 16:39:04 INFO - 'PAGER': '/bin/cat', 16:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:04 INFO - 'PWD': '/builds/slave/test', 16:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:04 INFO - 'SHELL': '/bin/bash', 16:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T2HzdeTmTs/Listeners', 16:39:04 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 16:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:04 INFO - 'USER': 'cltbld', 16:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:04 INFO - 'XPC_FLAGS': '0x0', 16:39:04 INFO - 'XPC_SERVICE_NAME': '0', 16:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:39:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:39:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:39:07 INFO - Installing collected packages: mozsystemmonitor 16:39:07 INFO - Running setup.py install for mozsystemmonitor 16:39:07 INFO - Successfully installed mozsystemmonitor 16:39:07 INFO - Cleaning up... 16:39:07 INFO - Return code: 0 16:39:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110409490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe468ccb8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032d9f0>, '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 0x11008cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103208c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/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.T2HzdeTmTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:39:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:39:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/Render', 16:39:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:07 INFO - 'HOME': '/Users/cltbld', 16:39:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:07 INFO - 'LOGNAME': 'cltbld', 16:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:07 INFO - 'MOZ_NO_REMOTE': '1', 16:39:07 INFO - 'NO_EM_RESTART': '1', 16:39:07 INFO - 'PAGER': '/bin/cat', 16:39:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:07 INFO - 'PWD': '/builds/slave/test', 16:39:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:07 INFO - 'SHELL': '/bin/bash', 16:39:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T2HzdeTmTs/Listeners', 16:39:07 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 16:39:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:07 INFO - 'USER': 'cltbld', 16:39:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:07 INFO - 'XPC_FLAGS': '0x0', 16:39:07 INFO - 'XPC_SERVICE_NAME': '0', 16:39:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:07 INFO - Downloading/unpacking blobuploader==1.2.4 16:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:09 INFO - Downloading blobuploader-1.2.4.tar.gz 16:39:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:39:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:39:09 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 16:39:09 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 16:39:09 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 16:39:09 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 16:39:09 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 16:39:09 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 16:39:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:39:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:10 INFO - Downloading docopt-0.6.1.tar.gz 16:39:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:39:10 INFO - Installing collected packages: blobuploader, requests, docopt 16:39:10 INFO - Running setup.py install for blobuploader 16:39:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:39:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:39:10 INFO - Running setup.py install for requests 16:39:11 INFO - Running setup.py install for docopt 16:39:11 INFO - Successfully installed blobuploader requests docopt 16:39:11 INFO - Cleaning up... 16:39:11 INFO - Return code: 0 16:39:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:11 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 0x110409490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe468ccb8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032d9f0>, '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 0x11008cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103208c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/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.T2HzdeTmTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:11 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 16:39:11 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 16:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/Render', 16:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:11 INFO - 'HOME': '/Users/cltbld', 16:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:11 INFO - 'LOGNAME': 'cltbld', 16:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:11 INFO - 'MOZ_NO_REMOTE': '1', 16:39:11 INFO - 'NO_EM_RESTART': '1', 16:39:11 INFO - 'PAGER': '/bin/cat', 16:39:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:11 INFO - 'PWD': '/builds/slave/test', 16:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:11 INFO - 'SHELL': '/bin/bash', 16:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T2HzdeTmTs/Listeners', 16:39:11 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 16:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:11 INFO - 'USER': 'cltbld', 16:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:11 INFO - 'XPC_FLAGS': '0x0', 16:39:11 INFO - 'XPC_SERVICE_NAME': '0', 16:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:39:11 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-DwML64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:39:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-9m3MHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:39:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-LTh8yI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:39:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-gud9ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:39:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-AcjF2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:39:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-LzYtGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:39:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-CaZoZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:39:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-UYa60V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:39:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-GypkOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:39:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-xiE1wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:39:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:39:12 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-p996ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:39:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-2QOZ1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:39:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-KBptZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:39:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-H0tnc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-uQoSLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:39:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-SWaFwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:39:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:39:13 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-hf82k_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:39:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:39:13 INFO - Running setup.py install for manifestparser 16:39:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:39:13 INFO - Running setup.py install for mozcrash 16:39:13 INFO - Running setup.py install for mozdebug 16:39:14 INFO - Running setup.py install for mozdevice 16:39:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:39:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:39:14 INFO - Running setup.py install for mozfile 16:39:14 INFO - Running setup.py install for mozhttpd 16:39:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:39:14 INFO - Running setup.py install for mozinfo 16:39:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:39:14 INFO - Running setup.py install for mozInstall 16:39:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:39:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:39:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:39:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:39:14 INFO - Running setup.py install for mozleak 16:39:14 INFO - Running setup.py install for mozlog 16:39:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:39:15 INFO - Running setup.py install for moznetwork 16:39:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:39:15 INFO - Running setup.py install for mozprocess 16:39:15 INFO - Running setup.py install for mozprofile 16:39:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:39:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:39:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:39:15 INFO - Running setup.py install for mozrunner 16:39:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:39:15 INFO - Running setup.py install for mozscreenshot 16:39:15 INFO - Running setup.py install for moztest 16:39:16 INFO - Running setup.py install for mozversion 16:39:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:39:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:39:16 INFO - Cleaning up... 16:39:16 INFO - Return code: 0 16:39:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x110409490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe468ccb8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032d9f0>, '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 0x11008cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103208c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/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.T2HzdeTmTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:16 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 16:39:16 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 16:39:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/Render', 16:39:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:16 INFO - 'HOME': '/Users/cltbld', 16:39:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:16 INFO - 'LOGNAME': 'cltbld', 16:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:16 INFO - 'MOZ_NO_REMOTE': '1', 16:39:16 INFO - 'NO_EM_RESTART': '1', 16:39:16 INFO - 'PAGER': '/bin/cat', 16:39:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:16 INFO - 'PWD': '/builds/slave/test', 16:39:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:16 INFO - 'SHELL': '/bin/bash', 16:39:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T2HzdeTmTs/Listeners', 16:39:16 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 16:39:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:16 INFO - 'USER': 'cltbld', 16:39:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:16 INFO - 'XPC_FLAGS': '0x0', 16:39:16 INFO - 'XPC_SERVICE_NAME': '0', 16:39:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:39:16 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-N_gQff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:39:16 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)) 16:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:39:16 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-IUXxsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:39:16 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)) 16:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:39:16 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-itgMC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:39:16 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)) 16:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:39:16 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-b8OTuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:39:16 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)) 16:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:39:16 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-R9Ptws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:39:17 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)) 16:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:39:17 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-JBS5cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:39:17 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)) 16:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:39:17 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-rTJmYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:39:17 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)) 16:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:39:17 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-5dzwmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:39:17 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)) 16:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:39:17 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-6vv36T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:39:17 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)) 16:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:39:17 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-EzBDdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:39:17 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)) 16:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:39:17 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-B2E0xe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:39:17 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)) 16:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:39:17 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-B0UYu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:39:17 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)) 16:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:39:17 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-mXGgEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:39:17 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)) 16:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:39:17 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-JKY4g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:39:18 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)) 16:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:18 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-YELtRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:39:18 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)) 16:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:39:18 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-XloZ76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:39:18 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)) 16:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:39:18 INFO - Running setup.py (path:/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/pip-zIVW3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:39:18 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)) 16:39:18 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)) 16:39:18 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)) 16:39:18 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)) 16:39:18 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)) 16:39:18 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)) 16:39:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:39:20 INFO - Downloading blessings-1.5.1.tar.gz 16:39:20 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 16:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:39:20 INFO - Installing collected packages: blessings 16:39:20 INFO - Running setup.py install for blessings 16:39:20 INFO - Successfully installed blessings 16:39:20 INFO - Cleaning up... 16:39:20 INFO - Return code: 0 16:39:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:39:20 INFO - Reading from file tmpfile_stdout 16:39:20 INFO - Current package versions: 16:39:20 INFO - blessings == 1.5.1 16:39:20 INFO - blobuploader == 1.2.4 16:39:20 INFO - docopt == 0.6.1 16:39:20 INFO - manifestparser == 1.1 16:39:20 INFO - mozInstall == 1.12 16:39:20 INFO - mozcrash == 0.16 16:39:20 INFO - mozdebug == 0.1 16:39:20 INFO - mozdevice == 0.47 16:39:20 INFO - mozfile == 1.2 16:39:20 INFO - mozhttpd == 0.7 16:39:20 INFO - mozinfo == 0.9 16:39:20 INFO - mozleak == 0.1 16:39:20 INFO - mozlog == 3.0 16:39:20 INFO - moznetwork == 0.27 16:39:20 INFO - mozprocess == 0.22 16:39:20 INFO - mozprofile == 0.27 16:39:20 INFO - mozrunner == 6.11 16:39:20 INFO - mozscreenshot == 0.1 16:39:20 INFO - mozsystemmonitor == 0.0 16:39:20 INFO - moztest == 0.7 16:39:20 INFO - mozversion == 1.4 16:39:20 INFO - psutil == 3.1.1 16:39:20 INFO - requests == 1.2.3 16:39:20 INFO - wsgiref == 0.1.2 16:39:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:39:20 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')]} 16:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:20 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')]} 16:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:39:20 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 0x110409490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103e6228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe468ccb8b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11032d9f0>, '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 0x11008cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103208c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/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.T2HzdeTmTs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:39:20 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 16:39:20 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 16:39:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/Render', 16:39:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:20 INFO - 'HOME': '/Users/cltbld', 16:39:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:20 INFO - 'LOGNAME': 'cltbld', 16:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:20 INFO - 'MOZ_NO_REMOTE': '1', 16:39:20 INFO - 'NO_EM_RESTART': '1', 16:39:20 INFO - 'PAGER': '/bin/cat', 16:39:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:21 INFO - 'PWD': '/builds/slave/test', 16:39:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:21 INFO - 'SHELL': '/bin/bash', 16:39:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T2HzdeTmTs/Listeners', 16:39:21 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 16:39:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:21 INFO - 'USER': 'cltbld', 16:39:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:21 INFO - 'XPC_FLAGS': '0x0', 16:39:21 INFO - 'XPC_SERVICE_NAME': '0', 16:39:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:39:21 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)) 16:39:21 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)) 16:39:21 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)) 16:39:21 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)) 16:39:21 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)) 16:39:21 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)) 16:39:21 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)) 16:39:21 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)) 16:39:21 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)) 16:39:21 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)) 16:39:21 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)) 16:39:21 INFO - Cleaning up... 16:39:21 INFO - Return code: 0 16:39:21 INFO - Running post-action listener: _resource_record_post_action 16:39:21 INFO - Running post-action listener: _start_resource_monitoring 16:39:21 INFO - Starting resource monitoring. 16:39:21 INFO - ##### 16:39:21 INFO - ##### Running install step. 16:39:21 INFO - ##### 16:39:21 INFO - Running pre-action listener: _resource_record_pre_action 16:39:21 INFO - Running main action method: install 16:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:39:21 INFO - Reading from file tmpfile_stdout 16:39:21 INFO - Detecting whether we're running mozinstall >=1.0... 16:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:39:21 INFO - Reading from file tmpfile_stdout 16:39:21 INFO - Output received: 16:39:21 INFO - Usage: mozinstall [options] installer 16:39:21 INFO - Options: 16:39:21 INFO - -h, --help show this help message and exit 16:39:21 INFO - -d DEST, --destination=DEST 16:39:21 INFO - Directory to install application into. [default: 16:39:21 INFO - "/builds/slave/test"] 16:39:21 INFO - --app=APP Application being installed. [default: firefox] 16:39:21 INFO - mkdir: /builds/slave/test/build/application 16:39:21 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'] 16:39:21 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 16:39:52 INFO - Reading from file tmpfile_stdout 16:39:52 INFO - Output received: 16:39:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:39:52 INFO - Running post-action listener: _resource_record_post_action 16:39:52 INFO - ##### 16:39:52 INFO - ##### Running run-tests step. 16:39:52 INFO - ##### 16:39:52 INFO - Running pre-action listener: _resource_record_pre_action 16:39:52 INFO - Running main action method: run_tests 16:39:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:39:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:39:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:39:52 INFO - 2015-11-20 16:39:52.259 screenresolution[1649:7896] starting screenresolution argv=screenresolution get 16:39:52 INFO - 2015-11-20 16:39:52.261 screenresolution[1649:7896] Display 0: 1600x1200x32@60 16:39:52 INFO - 2015-11-20 16:39:52.266 screenresolution[1650:7898] starting screenresolution argv=screenresolution list 16:39:52 INFO - Available Modes on Display 0 16:39:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:39:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:39:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:39:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:39:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:39:52 INFO - Intel Iris: 16:39:52 INFO - Chipset Model: Intel Iris 16:39:52 INFO - Type: GPU 16:39:52 INFO - Bus: Built-In 16:39:52 INFO - VRAM (Dynamic, Max): 1536 MB 16:39:52 INFO - Vendor: Intel (0x8086) 16:39:52 INFO - Device ID: 0x0a2e 16:39:52 INFO - Revision ID: 0x0009 16:39:52 INFO - Displays: 16:39:52 INFO - Display: 16:39:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:39:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:39:52 INFO - Display Serial Number: 1600x1200 60 16:39:52 INFO - Main Display: Yes 16:39:52 INFO - Mirror: Off 16:39:52 INFO - Online: Yes 16:39:52 INFO - Rotation: Supported 16:39:52 INFO - Return code: 0 16:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:39:52 INFO - Python 2.7.3 16:39:52 INFO - Return code: 0 16:39:52 INFO - grabbing minidump binary from tooltool 16:39:52 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')]} 16:39:52 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 0x11032d9f0>, '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 0x11008cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1103208c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:39:52 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 16:39:52 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 16:39:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:39:52 INFO - Return code: 0 16:39:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:39:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:39:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:39:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:39:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:39:52 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/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--webServer', 'localhost'] in /builds/slave/test/build 16:39:52 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/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0013 --webServer localhost 16:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1wBvGe8y4P/Render', 16:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:39:52 INFO - 'HOME': '/Users/cltbld', 16:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:39:52 INFO - 'LOGNAME': 'cltbld', 16:39:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:39:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:39:52 INFO - 'MOZ_NO_REMOTE': '1', 16:39:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:39:52 INFO - 'NO_EM_RESTART': '1', 16:39:52 INFO - 'PAGER': '/bin/cat', 16:39:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:39:52 INFO - 'PWD': '/builds/slave/test', 16:39:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:39:52 INFO - 'SHELL': '/bin/bash', 16:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T2HzdeTmTs/Listeners', 16:39:52 INFO - 'TMPDIR': '/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/', 16:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:39:52 INFO - 'USER': 'cltbld', 16:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:39:52 INFO - 'XPC_FLAGS': '0x0', 16:39:52 INFO - 'XPC_SERVICE_NAME': '0', 16:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:39:52 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/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0013', '--webServer', 'localhost'] with output_timeout 3600 16:39:52 INFO - mozversion INFO | application_buildid: 20151120143736 16:39:52 INFO - mozversion INFO | application_changeset: e3d9cf3dc32654aaccbb9ff95930521d2b87a151 16:39:52 INFO - mozversion INFO | application_display_name: Nightly 16:39:52 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:39:52 INFO - mozversion INFO | application_name: Firefox 16:39:52 INFO - mozversion INFO | application_remotingname: firefox 16:39:52 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 16:39:52 INFO - mozversion INFO | application_vendor: Mozilla 16:39:52 INFO - mozversion INFO | application_version: 45.0a1 16:39:52 INFO - mozversion INFO | platform_buildid: 20151120143736 16:39:52 INFO - mozversion INFO | platform_changeset: e3d9cf3dc32654aaccbb9ff95930521d2b87a151 16:39:52 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 16:39:52 INFO - mozversion INFO | platform_version: 45.0a1 16:39:52 INFO - 2015-11-20 16:39:52,812 DEBUG : using testdate: 1448066392 16:39:52 INFO - 2015-11-20 16:39:52,812 DEBUG : actual date: 1448066392 16:39:53 INFO - 2015-11-20 16:39:53,165 INFO : starting webserver on 'localhost:49262' 16:39:53 INFO - 2015-11-20 16:39:53,166 INFO : Starting test suite t-yosemite-r7-0013.e 16:39:53 INFO - 2015-11-20 16:39:53,166 INFO : Starting test dromaeo_css 16:39:53 INFO - 2015-11-20 16:39:53,166 DEBUG : operating with platform_type : mac_ 16:39:53 INFO - 2015-11-20 16:39:53,168 INFO : Initialising browser for dromaeo_css test... 16:39:53 INFO - 2015-11-20 16:39:53,180 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpnrOWCf/profile http://localhost:49262/getInfo.html 16:39:56 INFO - 2015-11-20 16:39:56,258 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:39:56 INFO - 2015-11-20 16:39:56,259 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:39:56 INFO - 2015-11-20 16:39:56,259 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:39:56 INFO - 2015-11-20 16:39:56,260 DEBUG : BROWSER_OUTPUT: __metrics 16:39:56 INFO - 2015-11-20 16:39:56,869 INFO : Browser initialized. 16:39:56 INFO - 2015-11-20 16:39:56,870 INFO : Running cycle 1/1 for dromaeo_css test... 16:39:56 INFO - 2015-11-20 16:39:56,870 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpnrOWCf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:40:08 INFO - 2015-11-20 16:40:08,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 237154304 16:40:08 INFO - 2015-11-20 16:40:08,822 DEBUG : BROWSER_OUTPUT: 16:40:58 INFO - 2015-11-20 16:40:58,515 DEBUG : BROWSER_OUTPUT: 1448066458512 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] 16:43:09 INFO - 2015-11-20 16:43:09,919 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 16:43:11 INFO - 2015-11-20 16:43:11,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 253173760 16:43:11 INFO - 2015-11-20 16:43:11,135 DEBUG : BROWSER_OUTPUT: 16:46:13 INFO - 2015-11-20 16:46:13,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 16:46:13 INFO - 2015-11-20 16:46:13,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 263069696 16:46:13 INFO - 2015-11-20 16:46:13,768 DEBUG : BROWSER_OUTPUT: 16:49:15 INFO - 2015-11-20 16:49:15,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 16:49:16 INFO - 2015-11-20 16:49:16,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 262934528 16:49:16 INFO - 2015-11-20 16:49:16,008 DEBUG : BROWSER_OUTPUT: 16:52:17 INFO - 2015-11-20 16:52:17,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 16:52:18 INFO - 2015-11-20 16:52:18,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 266149888 16:52:18 INFO - 2015-11-20 16:52:18,198 DEBUG : BROWSER_OUTPUT: 16:55:20 INFO - 2015-11-20 16:55:20,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 16:55:21 INFO - 2015-11-20 16:55:21,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 269004800 16:55:21 INFO - 2015-11-20 16:55:21,386 DEBUG : BROWSER_OUTPUT: 16:58:23 INFO - 2015-11-20 16:58:23,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 16:58:23 INFO - 2015-11-20 16:58:23,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 272494592 16:58:23 INFO - 2015-11-20 16:58:23,720 DEBUG : BROWSER_OUTPUT: 16:58:23 INFO - 2015-11-20 16:58:23,720 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:58:23 INFO - 2015-11-20 16:58:23,720 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:58:23 INFO - 2015-11-20 16:58:23,721 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:58:23 INFO - 2015-11-20 16:58:23,721 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:58:23 INFO - 2015-11-20 16:58:23,721 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3103.705148010939;3462.186386199243;3523.330567192235;3574.839132239049;3576.2489877125804;5688.288963879515;5819;5875.794347197849;5880.353161152269;5892.705364731757;5802.738876750545;5877.9412205877925;5915.5859089863725;6009.098635204721;6121.418465245794;5267.26258323835;5321.4412486688925;5391.029614669358;5404.621676482648;5449.6730196188155;5437.157240627709;5444.91832622511;5457.836264912059;5495.807646732365;5567.693776842272;5152.433232344439;5223.373195216598;5249.4488078751565;5390.218418329359;5397.568194544427;5358.705271210082;5367.194920761878;5388.43421440747;5410.756515956791;5419.972900135514;3955.703322250814;5355.116405793039;5370.087085195526;5391.622586418952;5395.622306438551;4744.430668319824;5547.25112109868;5727.284089488814;5809.302883653946;5874.853128671774;5562.9443705563235;6312.368763123697;6318.210223722035;6331.588446750947;6351.809445716636;4775;4838.758062096881;6147.586055207283;6265.59273647216;6402.071699603532;4996.925046124347;5858.179854820329;5927.318358388754;5987.700614969234;5988.131720900445;6216.4405203531;6533.967330163318;6572.967135164294;6584.111144995364;6648.800535983928;6107.401224262706;6130.601510901866;6136.917362303815;6266.216722909637;6267.62394256346;6333.113364129025;6340.239171299474;6433.4209921106385;6461.515386346043;6462.4183823456115;6287;6291.1192433059405;6334.429901308904;6349.206349206349;6351.682415879188;5188.481151884781;6145.600535965237;6261.186045814015;6290.4653104485715;6326.810195694136;5117.309163262912;5119.257707632372;5131.076406246912;5148.56237219833;5149.407818100892;4633.930491042637;4655.2784318430695;4665.323528088476;4678.157931572349;4690.9765451172525;5838.036723940587;5847.1229315603;5930.406959304035;6002.759889604367;6078.45293923549;6350.0944121966095;6431.099646049557;6438.291787903327;6465.967670161619;6469.482441404771;5863.091220860773;6111.899858025598;6117.785877494266;6121.47967422774;6122.051082082285;5489.176623506426;5509.752061157257;5530.391656917735;5540.390557038722;5574;6335.429811317003;6337.144485494584;6341.619502829845;6352.269489008823;6357.841053973502;6139.693015349304;6163.630182189083;6187.226596675416;6415.935840641534;6425.839354016187;5154.458781827854;6207.255129384503;6222.657753823402;6258.718357673824;6305;5392.51467367923;6250.781222657185;6279.340669229665;6314.557980941474;6334.8733025338315;6155.692215389302;6181.690915454119;6274;6325.272593651789;6332.905006425;6246.344133865879;6264.185655864709;6267.0599410087025;6275.058741188858;6288.685565721604;6269.404406581368;6272.40412160844;6274.780382686584;6284.5600807943;6295.1186833842385;5983.431574000463;6102.1762062122825;6121.204243448323;6144.556029333014;6244.594101383395;6104.639565963084;6194.318624951162;6279.497640188865;6282.371762823864;6284.465820405134;6264.310925798068;6299.149614801943;6302.779402720883;6313.715882785194;6315.810525684236 16:58:23 INFO - 2015-11-20 16:58:23,724 DEBUG : BROWSER_OUTPUT: |1;ext.html;548.8414715257693;572.153213244398;572.8682403047301;592.9149656129284;635.7043974551832;27820;28765.280867978287;37689.68086116983;39044.609553904455;39264.80367598165;43168.56831431685;43297.7835110824;43374.7831260844;43463;43598.34602480965;9877.90122098777;9951.402915825074;10035.34770239932;10042;10051.748706282366;9807.41155530667;9894.90105098947;9903.55434005468;9916.454594997273;9916.851247231298;9780.266480013992;9882.209423246159;9888.604455821758;9907.504624768733;9914.206863450907;9755.951220243924;9867.703968880945;9890.456024918627;9902.950485247527;9961.103500684936;9775;9896.356736812084;9904.603815847357;9908.653197138066;9962.701118966443;41495.58504414948;41600;41815;41984.79007604942;42117;3136.7333776629016;3152.7477801775804;3373.8987830365127;3414.3171365726707;4041.595840415935;24285.757142428527;28505.572416413772;28872.566911496346;29510.11469655892;29740;2706.174616741893;2835.6455443069617;2856.7286107819723;2859.070801989362;2956.659984101834;495850;496276;498732;499950;500793;58394.41605583975;59237.407625924054;63099;63731;63896.041559376645;71586.64206678934;71955.64022179856;72454;72674.9098763519;72985.6350718243;14650.706985860223;14668.193249371174;14728.779068313985;14785.482508112165;14825.555233343017;12872.93563532195;12873.806892896613;12974.675633109247;13045;13054.21674699502;15995.12026838535;19812;19953;20064.799352006587;20084.69872951907;8613.48319100856;8821.470711757314;8873.689420870238;8879.778005549784;8913.732588022369;875.2341701011615;900.9548923249;1008.5476913244904;1026.4918865161644;1103.4096758234466;28154;28664.283392914927;29856.55215171774;30504.222097710855;30856.920007799617;1061.0874647802884;1081.643057790927;1090.9945450272699;1136.4829002803704;1207.7342984543386;13882.652933676738;14478.638034049232;14610.853891460949;14848.406063757544;15889.967152135074;721893;726126;731023;732513;733605;58257.70871145617;58923.70538147282;58927.41072589305;58988;59065.40934590685;1453.2152637575591;1459.503768718662;1485.6434455730546;1493.7087267982856;1504.0148702599815;22651.773482264965;25830.095946641777;29927;30234.84882575573;31044.22389440282;43668;49838.750806245735;49914.750426247636;50084;50139;470552;471097;471239;473356;475741;29085.418291634473;30219.7912083523;34106.31787364189;34271.485927711605;34398.248140149226;42805.57194428016;43549.346759799264;43922.34116488192;43925;44584.77707611441;36994.44508332323;37896.242075158894;38419.80790096144;38529;38637;33361;35354.46968295426;36013.63986360103;36546;37440.251194975404;37530.68642597496;37583;37914.43128353022;38051.80974095112;38087.428688570246;33695.663043369255;33733;33914.98255052352;33962.15094622654;34199.65800342064;24280.1501947431;24299.392515186555;24524.877375613007;24850.254492365257;25581 16:58:23 INFO - 2015-11-20 16:58:23,725 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.42421277530406;358.22265683466856;366.37167258152294;367.9908002299942;370.0711214850724;16181.919090404532;19269.71095433568;19393.515162120955;20046.799532004676;20479.180832766673;14522.491712790055;14551.417943282257;14653.607907248821;19162.71255931162;19882;5798.217240672508;5910.527157827385;5982.102684597302;5987.251593550806;5996.340402555716;3773.792441415721;3907.33575292201;4609.239475486541;5702.54379649627;5989.580729348925;5620.409856965021;5669.603127781057;5705.65766054036;5709.543236541067;5709.886572118438;5594.328680558338;6297.118403423525;6319.8736025279695;6344.080108384258;6372.299047104815;5504.4770746778995;5521.668699878021;5544.085225937715;5546.251256080418;5573.024720673866;12243.816342754866;12449.066320025944;12690.11169218155;12705.618831435071;12719;1895.924163033477;1984.9305274315475;2057.341650671786;2085.95828083439;2174.521605246843;9492.667756628554;9606;9786.168175705003;9927.751806204902;9943.254255930835;1643.6301832087804;1746.772919520467;1753.6229710612151;1795.0306834309458;1801.8378345948927;58850.528736781496;59971.700141499015;100461;105138;105877;10658.78682426347;10940.070094042096;10957.561697532168;11012.119030477543;11096.389698566494;13040.869591303965;13099.345032748324;13133.737325253442;13156.736865262641;13208;8509.446885952393;8546.78633034179;8577.228049475578;8584.613692383859;8585.570721463902;7325.963370183115;8746.95626521876;8778.868316975251;8800.251978581764;8926.214757048616;4231.428757117811;4287.957120428819;4323.654107671378;4395.077033822869;4407.955920440819;1572.2138930534732;1579.676166385888;1735.496705955259;1777.8844375115575;1852.8147185281364;386.0637952964051;391.3698944699032;391.64947372101807;408.84463903716994;1007.7178390050798;8494.490330580185;10888.237823352447;11315.207935444605;11487.195896287347;11684.70788230301;432.9675274354436;437.43133925896205;449.59536417224103;923.7505873414141;944.6221511395497;10340.27618066728;10515.52680129396;10584.576616935236;10650.094741946867;10828.78342433147;745437;751888;762067;763203;768875.2449902053;112718.43640781744;116520.41739791246;117729;118130;118352;1251.8310028146266;1253.129075292663;1254.1095821966323;1255.29076072019;1275.9170653907465;17266.22301996388;17285.135743212537;17381.56546086358;17455.669674043947;17473.38843140484;37232.06919827026;45130.54869451395;48721.756391217816;49794.00411991667;51013;65874.35314116994;66023;67870.66064669644;69170.65414673096;69417.65291173512;9658.3722058066;9771.267154963263;9920.206383489447;10007.849882251918;10011.749706257402;15004;17304.480865574053;19421;19824.10791514414;19833.20667173297;14062.367193476523;15534.378624854879;15549;15822.287997040392;16033.67932641364;11461.598844040753;14314.783243424426;15832.841671583597;15941.36234550605;16281.511554652905;16272.837271627606;16286.18569071518;16534.33862645529;16800.495985120466;16947.237374318433;9730.36752611078;9842.852357214791;9935.751606209902;10116.08955194036;10176.338537995007;15323.233838308262;15775.842241577437;16091.597710057342;16253.106079165287;16392.18039098064 16:58:23 INFO - 2015-11-20 16:58:23,727 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1561.656435584171;1599.1284749811352;1924.5573518090844;1950.434374031531;1970.3793305108888;7409;7512.699492020312;8452.830943381128;8843.602037908293;8884.378093533447;8284.33725301976;8437.957810210955;8520.744377668665;8527.317814574835;8551.572421378922;2365.881705914706;2404.4229384947575;2411.3248290478696;2416.830821842472;2419.080749315258;2411.2886698423918;2441.841280316774;2446.7675570820743;2452.141750387368;2461.507698460306;2358.3868194269444;2385.9642105368434;2402.0631953538136;2415.1667674652217;2423.660687503751;2361.7874391304863;2405.891734871926;2407.0853075831246;2417.721961974378;2420.1529464687396;2392.964105538418;2434.415740222352;2448.9142879999295;2451.117597664839;2458.766417190364;8437.704680336159;8514.020887597944;8516.74449766508;8523;8535.359848011361;4631.374764406795;5152.768125434364;5226.52961233487;5252.474752524717;5264.499872512105;3189.6331921829055;3495.2834668892815;3507.228409749851;3563.394222982073;3572.428411454181;1024.8257796174669;1039.4646756920192;1042.7653777899989;1072.447689439939;1073.4954571351452;11189.16081293898;11252.38111903845;11269.549218031269;11277.774444511064;11290.717732056764;4715.528447155257;4750.216214324667;4861.440934292531;4876.683015603974;4879.682820616648;9707.223422126213;9775.90224097764;9794.020597940149;9803;9816.165625921876;5278.996990571779;5322.121849894801;5325.627206095536;5350.38470575881;5370.275012873212;4816.157172494799;4837.93565415608;4868.586170175575;4873.488283730228;4892.143874821892;3861.3242682530445;3916.804159792056;3936.488256526633;3949;3950.4271880577157;1297;1300.14840279617;1304.2239867278954;1306.372940988312;1318.6241921052454;1389.7359501694646;1393.261571367177;1407.1486750515994;1410.4851729119002;1432.2480697633825;7045.225025247219;8074.919250807534;8128.431009829374;8128.471649342892;8142.552159631158;489.6988352163394;494.99752501237265;497.9676321039121;498.36209651645953;498.4492136189531;5850.736716847752;6148.661823599745;6182.412670796267;6202.2867370253;6229.0967809667345;9331.906680933103;10022.997700230064;10283.920188380262;10383.584656613652;10403.687889363331;8345.66617335312;9963.501824908726;10216.489175541343;10217.540210690537;10296.176305895511;6907.516473846783;8021.5187088774865;8023.876657267987;8120.431569790058;8190.631421585924;7638.427117966064;7692.92307076922;7710.92289077102;7715.305622494003;7753.844923101394;9104.726858194264;9136.08639136081;9281.303902207497;9297.209737172145;9305.348625596143;9320.906790932275;9379.108984646447;9420.764480888032;9559.044095590385;9605.03949605034;7299.452541059336;7316.0489136411925;7326.120865496175;7343.44924130703;7353.301436363537;8149.8370032600205;8156.0620528639965;8199.631016604148;8222.259996600334;8237.423380363318;7552.980347652997;7641.159472457914;7655.923440765521;7669;7701.961490192513;7307.3423391894985;7350.742724004848;7488.438367122597;7539.095308563007;7569.053868266466;7629.847403051797;7702.807429814299;7709.113451953097;7721.03487064117;7740.303372696484;6917.550359226634;6977.058097156819;6987.336203060904;7000.789976300719;7020.403265722471;7072.151341839012;7091.716331346688;7110.253423390676;7119.252478489684;7126.536775109601 16:58:23 INFO - 2015-11-20 16:58:23,730 DEBUG : BROWSER_OUTPUT: |4;prototype.html;271.7404878341184;278.8844621513944;321.5883668903803;331.51929701932204;332.51286864743145;6853.862922741542;6870.278620744824;6885.931140688592;7024.789256322312;7047.1895731990835;6781.627010514419;6877.793666190022;6912.481563882704;6916.170059592856;6927.653617319126;4871.269309603553;4972.751362431882;5073.619478539106;5086.440491545945;5104.183330667103;4063.634272915437;4943.876403089916;4994.375703037121;5008.198688209887;5052.873678158038;4941.382327209099;4956.7769450374635;4966.453690094105;4977.950220497785;5010.849674509753;5002.7248501332415;5004.374453193351;5016.874578135539;5031.471695471978;5041.722705251228;3673.7244706647107;4120.484939382577;4189.72766770159;4233;4249.936250956238;5473.562115030788;6313.210848643919;6363.7454501819875;6516.1203237562795;6548.869022619521;5766.4233576642;5804.477597016289;5807.245058142415;5831.358550559435;5854.76580936762;7089.645517724145;7255.782326530212;7269.236730143364;7276.308750668678;7313.268673132698;3884.242572698325;4668.043051174535;4672.112298663277;4689.929651055237;4691.225947718656;6216.813495595139;7678;7759.224077592252;7810.258025487569;7812.960935195288;4748.810047598126;4763.166445872028;4764.6426518011285;4766.833160839354;4768.47546769855;4714.528547145258;4821.373221481185;4824.204006338915;4847.3698419205275;4871.732054737024;5769.394213607595;5847.1229315603;5849.303701926478;5849.707514624251;5861.238039054895;7385.9630701846145;7393.926060739432;7408.148062972827;7417.629118544051;7457.142428620778;1637.9918100409423;1664.5172899859147;1688.4596928982853;1693.7120689482817;1696.2706036404218;1029.5933106423072;1065.3661071662348;1081.118888106191;1081.5403453532217;1086.435053772034;6660.034295027194;6804.523683342119;6841.315868413219;6851.2121106072445;6874.2094659113845;6166.568340216142;7606.505577137468;7758.340541054074;7759.806004849924;7766.844663106706;6900.930990690129;6921.2732663069655;6922.8615427692175;6936.237013928464;6960.791176264619;3398.813065281384;3910.550286717007;4036.59634036594;4050.18996200761;4072.633462988286;7630.2751238632245;7646.923530764732;7676.270754278335;7698.884516732253;7701.884471732817;7902.960485197537;7918.089419716691;7928.286454219148;7944.523328600302;7950.840983180304;7471.887921681179;7693.961530192425;7746.883796743054;7784.961075194701;7793.454458187985;6396.488280937607;7570.015897933234;7719.768406947801;7744.65149068282;7754.573498457639;6271.529635277281;7314.780556583311;7555.848883022419;7558.962205188939;7567.583782891994;7721.227877212234;7728;7737.806554835949;7738.303552680286;7740.612969351398;4732.47942726293;4774.40319960005;4778.976105119591;4788.784504697227;4796.784144713426;7477.9530865679935;7664.271894170045;7683.308502234826;7705.1524332324525;7733.7679869604;7355.77932662021;7371.152317483344;7372.48392612512;7382.704691812267;7414.073240844895;6074.969625151846;7368.189499154982;7423.628818558943;7431.033965584439;7432.293932076444;6925.445964322943;7104.7513337035025;7203;7204.423646108194;7209.963950180216;7187.928120718726;7195.208527062124;7290.817729556804;7363.705451781869;7378.483506154517;7260.782176534713;7273.781786546412;7286.344229019413;7303.379212766762;7313.268673132644 16:58:23 INFO - 2015-11-20 16:58:23,732 DEBUG : BROWSER_OUTPUT: |5;yui.html;727.210976090941;772.582805285146;800.3757069485803;815.1970309245393;854.406187699549;14871.330790114444;15257.389704411838;15355.539333819976;15372.38510459583;15401.075935443867;16009.83990160098;16338.101404422752;16361;16368.590785230375;16420.589485262844;761.2463660975621;771.7183228121751;960.8510680844463;983.3509883476906;984.6849008317341;948.5257371314343;968.7771812483134;969.8787651543557;980.0738302304289;981.7300242433316;999.7850462150636;1004.3271008424373;1009.7828966772142;1010.1615659003047;1011.3022014809758;992.7319623701596;997.436448406648;1001.2840818814547;1003.7691330993912;1005.6178652112224;731.9414446844239;735.5770432001567;737.6827963975488;741.9258074192592;742.9814254643624;15420.151891645955;15542;15561.066336019874;15629.921850390789;15707.371705131782;12363.62909112728;12482.375881205904;12501.874981250163;12707.555235566802;13128.146670466389;9930.404175749478;10253.43606101664;10486.790264194673;10700.357978521313;11041.779164416666;3395.8302084895904;3476.217850983534;3574.3566158091535;3575.6424357564297;3579.6599323064265;77630.6118469404;77810;78061.60969195118;78089;78434;8400.621972011275;9257.259419246444;9260.259179265642;9316.20812230968;9442.339036267394;20839.791602083784;20942.685859712117;21060.578788424147;21100.47248818792;21108.894455527625;6884.414824739853;7265.200827908926;7340.816479588053;7439.888401673979;7617.390608751287;3556.928861422757;4173;4216.219999300078;4217.5782421758195;4223.598758117974;3508.8771892983623;3519.1729943463265;3538.327717733622;3543.7165026797793;3564.3584154851856;628.8930881750022;639.8528338482082;641.788209890735;649.3636236488268;649.4317472211815;591.73371982608;604.114971566657;610.2402508876388;614.4040280927583;621.0808004153878;7979.760607181794;8149.714759983491;8219.178082191853;8599.785005374915;8766.517841518778;518.3883018038675;552.6987791653559;619.3651507205151;621.8165641135876;631.7157279224275;3804.391297392404;4070.9389359159636;4078.9796051019557;4100.036491424513;4124.670026397881;93334;93960.53019734994;96617;97378;98180.50909745549;71366;72289.27710722825;73322;73951.63024184844;82341.17658823455;71104.28895710976;72091;73116;73447.53104937979;74953.62523187349;7380.557166570023;7647.005889234587;8936.642534298555;8945.776355591162;9032.277417806692;53000.46999530109;53019.46980530299;53448.73275633597;54190;54918.725406372716;71708;74438.25561744314;74478.51042979001;75567.62216188884;75876;10837.512311945824;11010.944945275221;11145.944270278922;11299.265547739371;11736.413179340829;11646.24299420535;11692.123090768056;11708.941455292668;12142.150049496804;12674.746505070032;11106.555737770723;11276.3797991108;11548.94225528867;11568.710782230512;11779.528818847493;11192.664220073411;11216.046636036028;11262.774744505228;11556.306621602731;12213.389330533615;9244.352895297265;10618.52216650268;10919.454027298445;11144.164187686118;11525.596604118815;9375.824328965018;9381.859272110787;9637.18083962871;9695.70912872615;9866.753331166778;7664.961675191588;8547.871781923152;9619.691274094306;9936.403815771077;9997.100260976547 16:58:23 INFO - 2015-11-20 16:58:23,732 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:58:23 INFO - 2015-11-20 16:58:23,732 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:58:23 INFO - 2015-11-20 16:58:23,732 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,324 16:58:23 INFO - 2015-11-20 16:58:23,732 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:58:23 INFO - 2015-11-20 16:58:23,732 DEBUG : BROWSER_OUTPUT: __startTimestamp1448067503718__endTimestamp 16:58:23 INFO - 2015-11-20 16:58:23,732 DEBUG : BROWSER_OUTPUT: 16:58:23 INFO - 2015-11-20 16:58:23,732 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:58:23 INFO - 2015-11-20 16:58:23,732 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:58:23 INFO - 2015-11-20 16:58:23,732 DEBUG : BROWSER_OUTPUT: 16:58:23 INFO - 2015-11-20 16:58:23,733 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5831.02 Median:6121.20 stddev:662.43 (10.8%) stddev-sans-first:628.96 16:58:23 INFO - 2015-11-20 16:58:23,734 DEBUG : BROWSER_OUTPUT: Values: 3103.7 3462.2 3523.3 3574.8 3576.2 5688.3 5819.0 5875.8 5880.4 5892.7 5802.7 5877.9 5915.6 6009.1 6121.4 5267.3 5321.4 5391.0 5404.6 5449.7 5437.2 5444.9 5457.8 5495.8 5567.7 5152.4 5223.4 5249.4 5390.2 5397.6 5358.7 5367.2 5388.4 5410.8 5420.0 3955.7 5355.1 5370.1 5391.6 5395.6 4744.4 5547.3 5727.3 5809.3 5874.9 5562.9 6312.4 6318.2 6331.6 6351.8 4775.0 4838.8 6147.6 6265.6 6402.1 4996.9 5858.2 5927.3 5987.7 5988.1 6216.4 6534.0 6573.0 6584.1 6648.8 6107.4 6130.6 6136.9 6266.2 6267.6 6333.1 6340.2 6433.4 6461.5 6462.4 6287.0 6291.1 6334.4 6349.2 6351.7 5188.5 6145.6 6261.2 6290.5 6326.8 5117.3 5119.3 5131.1 5148.6 5149.4 4633.9 4655.3 4665.3 4678.2 4691.0 5838.0 5847.1 5930.4 6002.8 6078.5 6350.1 6431.1 6438.3 6466.0 6469.5 5863.1 6111.9 6117.8 6121.5 6122.1 5489.2 5509.8 5530.4 5540.4 5574.0 6335.4 6337.1 6341.6 6352.3 6357.8 6139.7 6163.6 6187.2 6415.9 6425.8 5154.5 6207.3 6222.7 6258.7 6305.0 5392.5 6250.8 6279.3 6314.6 6334.9 6155.7 6181.7 6274.0 6325.3 6332.9 6246.3 6264.2 6267.1 6275.1 6288.7 6269.4 6272.4 6274.8 6284.6 6295.1 5983.4 6102.2 6121.2 6144.6 6244.6 6104.6 6194.3 6279.5 6282.4 6284.5 6264.3 6299.1 6302.8 6313.7 6315.8 16:58:23 INFO - 2015-11-20 16:58:23,734 DEBUG : BROWSER_OUTPUT: 16:58:23 INFO - 2015-11-20 16:58:23,734 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:70099.53 Median:38474.40 stddev:154878.88 (402.6%) stddev-sans-first:155225.32 16:58:23 INFO - 2015-11-20 16:58:23,735 DEBUG : BROWSER_OUTPUT: Values: 548.8 572.2 572.9 592.9 635.7 27820.0 28765.3 37689.7 39044.6 39264.8 43168.6 43297.8 43374.8 43463.0 43598.3 9877.9 9951.4 10035.3 10042.0 10051.7 9807.4 9894.9 9903.6 9916.5 9916.9 9780.3 9882.2 9888.6 9907.5 9914.2 9756.0 9867.7 9890.5 9903.0 9961.1 9775.0 9896.4 9904.6 9908.7 9962.7 41495.6 41600.0 41815.0 41984.8 42117.0 3136.7 3152.7 3373.9 3414.3 4041.6 24285.8 28505.6 28872.6 29510.1 29740.0 2706.2 2835.6 2856.7 2859.1 2956.7 495850.0 496276.0 498732.0 499950.0 500793.0 58394.4 59237.4 63099.0 63731.0 63896.0 71586.6 71955.6 72454.0 72674.9 72985.6 14650.7 14668.2 14728.8 14785.5 14825.6 12872.9 12873.8 12974.7 13045.0 13054.2 15995.1 19812.0 19953.0 20064.8 20084.7 8613.5 8821.5 8873.7 8879.8 8913.7 875.2 901.0 1008.5 1026.5 1103.4 28154.0 28664.3 29856.6 30504.2 30856.9 1061.1 1081.6 1091.0 1136.5 1207.7 13882.7 14478.6 14610.9 14848.4 15890.0 721893.0 726126.0 731023.0 732513.0 733605.0 58257.7 58923.7 58927.4 58988.0 59065.4 1453.2 1459.5 1485.6 1493.7 1504.0 22651.8 25830.1 29927.0 30234.8 31044.2 43668.0 49838.8 49914.8 50084.0 50139.0 470552.0 471097.0 471239.0 473356.0 475741.0 29085.4 30219.8 34106.3 34271.5 34398.2 42805.6 43549.3 43922.3 43925.0 44584.8 36994.4 37896.2 38419.8 38529.0 38637.0 33361.0 35354.5 36013.6 36546.0 37440.3 37530.7 37583.0 37914.4 38051.8 38087.4 33695.7 33733.0 33915.0 33962.2 34199.7 24280.2 24299.4 24524.9 24850.3 25581.0 16:58:23 INFO - 2015-11-20 16:58:23,736 DEBUG : BROWSER_OUTPUT: 16:58:23 INFO - 2015-11-20 16:58:23,736 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37623.63 Median:10933.47 stddev:124618.58 (1139.8%) stddev-sans-first:124936.74 16:58:23 INFO - 2015-11-20 16:58:23,736 DEBUG : BROWSER_OUTPUT: Values: 355.4 358.2 366.4 368.0 370.1 16181.9 19269.7 19393.5 20046.8 20479.2 14522.5 14551.4 14653.6 19162.7 19882.0 5798.2 5910.5 5982.1 5987.3 5996.3 3773.8 3907.3 4609.2 5702.5 5989.6 5620.4 5669.6 5705.7 5709.5 5709.9 5594.3 6297.1 6319.9 6344.1 6372.3 5504.5 5521.7 5544.1 5546.3 5573.0 12243.8 12449.1 12690.1 12705.6 12719.0 1895.9 1984.9 2057.3 2086.0 2174.5 9492.7 9606.0 9786.2 9927.8 9943.3 1643.6 1746.8 1753.6 1795.0 1801.8 58850.5 59971.7 100461.0 105138.0 105877.0 10658.8 10940.1 10957.6 11012.1 11096.4 13040.9 13099.3 13133.7 13156.7 13208.0 8509.4 8546.8 8577.2 8584.6 8585.6 7326.0 8747.0 8778.9 8800.3 8926.2 4231.4 4288.0 4323.7 4395.1 4408.0 1572.2 1579.7 1735.5 1777.9 1852.8 386.1 391.4 391.6 408.8 1007.7 8494.5 10888.2 11315.2 11487.2 11684.7 433.0 437.4 449.6 923.8 944.6 10340.3 10515.5 10584.6 10650.1 10828.8 745437.0 751888.0 762067.0 763203.0 768875.2 112718.4 116520.4 117729.0 118130.0 118352.0 1251.8 1253.1 1254.1 1255.3 1275.9 17266.2 17285.1 17381.6 17455.7 17473.4 37232.1 45130.5 48721.8 49794.0 51013.0 65874.4 66023.0 67870.7 69170.7 69417.7 9658.4 9771.3 9920.2 10007.8 10011.7 15004.0 17304.5 19421.0 19824.1 19833.2 14062.4 15534.4 15549.0 15822.3 16033.7 11461.6 14314.8 15832.8 15941.4 16281.5 16272.8 16286.2 16534.3 16800.5 16947.2 9730.4 9842.9 9935.8 10116.1 10176.3 15323.2 15775.8 16091.6 16253.1 16392.2 16:58:23 INFO - 2015-11-20 16:58:23,736 DEBUG : BROWSER_OUTPUT: 16:58:23 INFO - 2015-11-20 16:58:23,736 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5900.65 Median:5360.33 stddev:3058.90 (57.1%) stddev-sans-first:3050.10 16:58:23 INFO - 2015-11-20 16:58:23,737 DEBUG : BROWSER_OUTPUT: Values: 1561.7 1599.1 1924.6 1950.4 1970.4 7409.0 7512.7 8452.8 8843.6 8884.4 8284.3 8438.0 8520.7 8527.3 8551.6 2365.9 2404.4 2411.3 2416.8 2419.1 2411.3 2441.8 2446.8 2452.1 2461.5 2358.4 2386.0 2402.1 2415.2 2423.7 2361.8 2405.9 2407.1 2417.7 2420.2 2393.0 2434.4 2448.9 2451.1 2458.8 8437.7 8514.0 8516.7 8523.0 8535.4 4631.4 5152.8 5226.5 5252.5 5264.5 3189.6 3495.3 3507.2 3563.4 3572.4 1024.8 1039.5 1042.8 1072.4 1073.5 11189.2 11252.4 11269.5 11277.8 11290.7 4715.5 4750.2 4861.4 4876.7 4879.7 9707.2 9775.9 9794.0 9803.0 9816.2 5279.0 5322.1 5325.6 5350.4 5370.3 4816.2 4837.9 4868.6 4873.5 4892.1 3861.3 3916.8 3936.5 3949.0 3950.4 1297.0 1300.1 1304.2 1306.4 1318.6 1389.7 1393.3 1407.1 1410.5 1432.2 7045.2 8074.9 8128.4 8128.5 8142.6 489.7 495.0 498.0 498.4 498.4 5850.7 6148.7 6182.4 6202.3 6229.1 9331.9 10023.0 10283.9 10383.6 10403.7 8345.7 9963.5 10216.5 10217.5 10296.2 6907.5 8021.5 8023.9 8120.4 8190.6 7638.4 7692.9 7710.9 7715.3 7753.8 9104.7 9136.1 9281.3 9297.2 9305.3 9320.9 9379.1 9420.8 9559.0 9605.0 7299.5 7316.0 7326.1 7343.4 7353.3 8149.8 8156.1 8199.6 8222.3 8237.4 7553.0 7641.2 7655.9 7669.0 7702.0 7307.3 7350.7 7488.4 7539.1 7569.1 7629.8 7702.8 7709.1 7721.0 7740.3 6917.6 6977.1 6987.3 7000.8 7020.4 7072.2 7091.7 7110.3 7119.3 7126.5 16:58:23 INFO - 2015-11-20 16:58:23,737 DEBUG : BROWSER_OUTPUT: 16:58:23 INFO - 2015-11-20 16:58:23,737 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5952.88 Median:6862.07 stddev:1935.44 (28.2%) stddev-sans-first:1893.31 16:58:23 INFO - 2015-11-20 16:58:23,739 DEBUG : BROWSER_OUTPUT: Values: 271.7 278.9 321.6 331.5 332.5 6853.9 6870.3 6885.9 7024.8 7047.2 6781.6 6877.8 6912.5 6916.2 6927.7 4871.3 4972.8 5073.6 5086.4 5104.2 4063.6 4943.9 4994.4 5008.2 5052.9 4941.4 4956.8 4966.5 4978.0 5010.8 5002.7 5004.4 5016.9 5031.5 5041.7 3673.7 4120.5 4189.7 4233.0 4249.9 5473.6 6313.2 6363.7 6516.1 6548.9 5766.4 5804.5 5807.2 5831.4 5854.8 7089.6 7255.8 7269.2 7276.3 7313.3 3884.2 4668.0 4672.1 4689.9 4691.2 6216.8 7678.0 7759.2 7810.3 7813.0 4748.8 4763.2 4764.6 4766.8 4768.5 4714.5 4821.4 4824.2 4847.4 4871.7 5769.4 5847.1 5849.3 5849.7 5861.2 7386.0 7393.9 7408.1 7417.6 7457.1 1638.0 1664.5 1688.5 1693.7 1696.3 1029.6 1065.4 1081.1 1081.5 1086.4 6660.0 6804.5 6841.3 6851.2 6874.2 6166.6 7606.5 7758.3 7759.8 7766.8 6900.9 6921.3 6922.9 6936.2 6960.8 3398.8 3910.6 4036.6 4050.2 4072.6 7630.3 7646.9 7676.3 7698.9 7701.9 7903.0 7918.1 7928.3 7944.5 7950.8 7471.9 7694.0 7746.9 7785.0 7793.5 6396.5 7570.0 7719.8 7744.7 7754.6 6271.5 7314.8 7555.8 7559.0 7567.6 7721.2 7728.0 7737.8 7738.3 7740.6 4732.5 4774.4 4779.0 4788.8 4796.8 7478.0 7664.3 7683.3 7705.2 7733.8 7355.8 7371.2 7372.5 7382.7 7414.1 6075.0 7368.2 7423.6 7431.0 7432.3 6925.4 7104.8 7203.0 7204.4 7210.0 7187.9 7195.2 7290.8 7363.7 7378.5 7260.8 7273.8 7286.3 7303.4 7313.3 16:58:23 INFO - 2015-11-20 16:58:23,739 DEBUG : BROWSER_OUTPUT: 16:58:23 INFO - 2015-11-20 16:58:23,739 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18667.25 Median:616.88 stddev:26263.46 (4257.4%) stddev-sans-first:26302.59 16:58:23 INFO - 2015-11-20 16:58:23,739 DEBUG : BROWSER_OUTPUT: Values: 727.2 772.6 800.4 815.2 854.4 14871.3 15257.4 15355.5 15372.4 15401.1 16009.8 16338.1 16361.0 16368.6 16420.6 761.2 771.7 960.9 983.4 984.7 948.5 968.8 969.9 980.1 981.7 999.8 1004.3 1009.8 1010.2 1011.3 992.7 997.4 1001.3 1003.8 1005.6 731.9 735.6 737.7 741.9 743.0 15420.2 15542.0 15561.1 15629.9 15707.4 12363.6 12482.4 12501.9 12707.6 13128.1 9930.4 10253.4 10486.8 10700.4 11041.8 3395.8 3476.2 3574.4 3575.6 3579.7 77630.6 77810.0 78061.6 78089.0 78434.0 8400.6 9257.3 9260.3 9316.2 9442.3 20839.8 20942.7 21060.6 21100.5 21108.9 6884.4 7265.2 7340.8 7439.9 7617.4 3556.9 4173.0 4216.2 4217.6 4223.6 3508.9 3519.2 3538.3 3543.7 3564.4 628.9 639.9 641.8 649.4 649.4 591.7 604.1 610.2 614.4 621.1 7979.8 8149.7 8219.2 8599.8 8766.5 518.4 552.7 619.4 621.8 631.7 3804.4 4070.9 4079.0 4100.0 4124.7 93334.0 93960.5 96617.0 97378.0 98180.5 71366.0 72289.3 73322.0 73951.6 82341.2 71104.3 72091.0 73116.0 73447.5 74953.6 7380.6 7647.0 8936.6 8945.8 9032.3 53000.5 53019.5 53448.7 54190.0 54918.7 71708.0 74438.3 74478.5 75567.6 75876.0 10837.5 11010.9 11145.9 11299.3 11736.4 11646.2 11692.1 11708.9 12142.2 12674.7 11106.6 11276.4 11548.9 11568.7 11779.5 11192.7 11216.0 11262.8 11556.3 12213.4 9244.4 10618.5 10919.5 11144.2 11525.6 9375.8 9381.9 9637.2 9695.7 9866.8 7665.0 8547.9 9619.7 9936.4 9997.1 16:58:23 INFO - 2015-11-20 16:58:23,739 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:58:23 INFO - 2015-11-20 16:58:23,739 DEBUG : BROWSER_OUTPUT: 16:58:24 INFO - 2015-11-20 16:58:24,239 INFO : Browser exited with error code: 0 16:58:24 INFO - 2015-11-20 16:58:24,263 INFO : Completed test dromaeo_css (00:18:31) 16:58:24 INFO - 2015-11-20 16:58:24,263 INFO : Starting test kraken 16:58:24 INFO - 2015-11-20 16:58:24,263 DEBUG : operating with platform_type : mac_ 16:58:24 INFO - 2015-11-20 16:58:24,264 INFO : Initialising browser for kraken test... 16:58:24 INFO - 2015-11-20 16:58:24,276 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpjSxnbw/profile http://localhost:49262/getInfo.html 16:58:26 INFO - 2015-11-20 16:58:26,828 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:58:26 INFO - 2015-11-20 16:58:26,829 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:58:26 INFO - 2015-11-20 16:58:26,829 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:58:26 INFO - 2015-11-20 16:58:26,829 DEBUG : BROWSER_OUTPUT: __metrics 16:58:27 INFO - 2015-11-20 16:58:27,416 INFO : Browser initialized. 16:58:27 INFO - 2015-11-20 16:58:27,416 INFO : Running cycle 1/1 for kraken test... 16:58:27 INFO - 2015-11-20 16:58:27,417 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpjSxnbw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:58:39 INFO - 2015-11-20 16:58:39,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 235778048 16:58:39 INFO - 2015-11-20 16:58:39,443 DEBUG : BROWSER_OUTPUT: 16:58:42 INFO - 2015-11-20 16:58:42,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 16:58:42 INFO - 2015-11-20 16:58:42,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 248397824 16:58:42 INFO - 2015-11-20 16:58:42,737 DEBUG : BROWSER_OUTPUT: 16:58:45 INFO - 2015-11-20 16:58:45,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 16:58:46 INFO - 2015-11-20 16:58:46,082 DEBUG : BROWSER_OUTPUT: RSS: Main: 259026944 16:58:46 INFO - 2015-11-20 16:58:46,082 DEBUG : BROWSER_OUTPUT: 16:58:49 INFO - 2015-11-20 16:58:49,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 16:58:49 INFO - 2015-11-20 16:58:49,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 262811648 16:58:49 INFO - 2015-11-20 16:58:49,876 DEBUG : BROWSER_OUTPUT: 16:58:51 INFO - 2015-11-20 16:58:51,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 16:58:52 INFO - 2015-11-20 16:58:52,318 DEBUG : BROWSER_OUTPUT: RSS: Main: 263438336 16:58:52 INFO - 2015-11-20 16:58:52,318 DEBUG : BROWSER_OUTPUT: 16:58:54 INFO - 2015-11-20 16:58:54,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:58:54 INFO - 2015-11-20 16:58:54,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 265211904 16:58:54 INFO - 2015-11-20 16:58:54,943 DEBUG : BROWSER_OUTPUT: 16:58:57 INFO - 2015-11-20 16:58:57,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 16:58:58 INFO - 2015-11-20 16:58:58,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 265019392 16:58:58 INFO - 2015-11-20 16:58:58,366 DEBUG : BROWSER_OUTPUT: 16:59:01 INFO - 2015-11-20 16:59:01,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 16:59:02 INFO - 2015-11-20 16:59:02,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 264933376 16:59:02 INFO - 2015-11-20 16:59:02,067 DEBUG : BROWSER_OUTPUT: 16:59:05 INFO - 2015-11-20 16:59:05,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 16:59:05 INFO - 2015-11-20 16:59:05,734 DEBUG : BROWSER_OUTPUT: RSS: Main: 265207808 16:59:05 INFO - 2015-11-20 16:59:05,734 DEBUG : BROWSER_OUTPUT: 16:59:07 INFO - 2015-11-20 16:59:07,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:59:07 INFO - 2015-11-20 16:59:07,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 264253440 16:59:07 INFO - 2015-11-20 16:59:07,838 DEBUG : BROWSER_OUTPUT: 16:59:09 INFO - 2015-11-20 16:59:09,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:59:10 INFO - 2015-11-20 16:59:10,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 264040448 16:59:10 INFO - 2015-11-20 16:59:10,346 DEBUG : BROWSER_OUTPUT: 16:59:12 INFO - 2015-11-20 16:59:12,455 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:59:13 INFO - 2015-11-20 16:59:13,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 264916992 16:59:13 INFO - 2015-11-20 16:59:13,041 DEBUG : BROWSER_OUTPUT: 16:59:15 INFO - 2015-11-20 16:59:15,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:59:16 INFO - 2015-11-20 16:59:16,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 264372224 16:59:16 INFO - 2015-11-20 16:59:16,198 DEBUG : BROWSER_OUTPUT: 16:59:18 INFO - 2015-11-20 16:59:18,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:59:19 INFO - 2015-11-20 16:59:19,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 264683520 16:59:19 INFO - 2015-11-20 16:59:19,344 DEBUG : BROWSER_OUTPUT: 16:59:20 INFO - 2015-11-20 16:59:20,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 16:59:21 INFO - 2015-11-20 16:59:21,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 264830976 16:59:21 INFO - 2015-11-20 16:59:21,219 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,219 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:59:21 INFO - 2015-11-20 16:59:21,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;115;123;149;125;118;111;94;169 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;143;141;175;157;125;171;171;149;158;150 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |2;audio-dft;191;189;191;204;223;193;203;203;205;201 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |3;audio-fft;59;58;58;69;102;56;55;59;58;109 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;77;76;105;85;113;116;93;59;74;123 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;131;130;91;86;87;86;86;91;86;121 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;95;103;152;113;150;98;101;152;152;94 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;82;106;116;101;94;141;83;142;151;145 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;58;61;58;60;60;67;59;58 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;66;65;65;67;85;92;102;60;101 16:59:21 INFO - 2015-11-20 16:59:21,220 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;84;85;83;82;84;99;110;85 16:59:21 INFO - 2015-11-20 16:59:21,221 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;133;126;126;126;119;119;150;142;109;134 16:59:21 INFO - 2015-11-20 16:59:21,221 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;132;183;152;137;156;141;138;140;176;126 16:59:21 INFO - 2015-11-20 16:59:21,221 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;65;66;66;66;66;67;67;66;67 16:59:21 INFO - 2015-11-20 16:59:21,221 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:59:21 INFO - 2015-11-20 16:59:21,221 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:59:21 INFO - 2015-11-20 16:59:21,221 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,804 16:59:21 INFO - 2015-11-20 16:59:21,221 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:59:21 INFO - 2015-11-20 16:59:21,221 DEBUG : BROWSER_OUTPUT: __startTimestamp1448067561216__endTimestamp 16:59:21 INFO - 2015-11-20 16:59:21,221 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,222 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:122.50 Median:124.00 stddev:21.61 (17.4%) stddev-sans-first:22.71 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 115.0 123.0 149.0 125.0 118.0 111.0 94.0 169.0 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:154.00 Median:157.50 stddev:15.69 (10.0%) stddev-sans-first:16.13 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: Values: 143.0 141.0 175.0 157.0 125.0 171.0 171.0 149.0 158.0 150.0 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:200.30 Median:203.00 stddev:10.11 (5.0%) stddev-sans-first:10.15 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: Values: 191.0 189.0 191.0 204.0 223.0 193.0 203.0 203.0 205.0 201.0 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,223 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:68.30 Median:58.00 stddev:20.03 (34.5%) stddev-sans-first:20.96 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 58.0 69.0 102.0 56.0 55.0 59.0 58.0 109.0 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:92.10 Median:75.00 stddev:21.32 (28.4%) stddev-sans-first:21.90 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: Values: 77.0 76.0 105.0 85.0 113.0 116.0 93.0 59.0 74.0 123.0 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:99.50 Median:86.00 stddev:19.48 (22.6%) stddev-sans-first:17.00 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: Values: 131.0 130.0 91.0 86.0 87.0 86.0 86.0 91.0 86.0 121.0 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:121.00 Median:152.00 stddev:26.76 (17.6%) stddev-sans-first:26.68 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: Values: 95.0 103.0 152.0 113.0 150.0 98.0 101.0 152.0 152.0 94.0 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:116.10 Median:148.00 stddev:26.71 (18.0%) stddev-sans-first:25.32 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: Values: 82.0 106.0 116.0 101.0 94.0 141.0 83.0 142.0 151.0 145.0 16:59:21 INFO - 2015-11-20 16:59:21,224 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,225 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.00 Median:60.00 stddev:2.67 (4.4%) stddev-sans-first:2.80 16:59:21 INFO - 2015-11-20 16:59:21,226 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 58.0 61.0 58.0 60.0 60.0 67.0 59.0 58.0 16:59:21 INFO - 2015-11-20 16:59:21,226 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,226 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:76.80 Median:65.50 stddev:16.44 (25.1%) stddev-sans-first:16.87 16:59:21 INFO - 2015-11-20 16:59:21,226 DEBUG : BROWSER_OUTPUT: Values: 65.0 66.0 65.0 65.0 67.0 85.0 92.0 102.0 60.0 101.0 16:59:21 INFO - 2015-11-20 16:59:21,226 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,226 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:84.50 stddev:9.04 (10.7%) stddev-sans-first:9.46 16:59:21 INFO - 2015-11-20 16:59:21,226 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 84.0 85.0 83.0 82.0 84.0 99.0 110.0 85.0 16:59:21 INFO - 2015-11-20 16:59:21,227 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,227 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:129.50 stddev:11.90 (9.2%) stddev-sans-first:12.50 16:59:21 INFO - 2015-11-20 16:59:21,227 DEBUG : BROWSER_OUTPUT: Values: 133.0 126.0 126.0 126.0 119.0 119.0 150.0 142.0 109.0 134.0 16:59:21 INFO - 2015-11-20 16:59:21,227 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,227 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:146.50 stddev:18.75 (12.8%) stddev-sans-first:18.96 16:59:21 INFO - 2015-11-20 16:59:21,227 DEBUG : BROWSER_OUTPUT: Values: 132.0 183.0 152.0 137.0 156.0 141.0 138.0 140.0 176.0 126.0 16:59:21 INFO - 2015-11-20 16:59:21,227 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,227 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 16:59:21 INFO - 2015-11-20 16:59:21,227 DEBUG : BROWSER_OUTPUT: Values: 67.0 65.0 66.0 66.0 66.0 66.0 67.0 67.0 66.0 67.0 16:59:21 INFO - 2015-11-20 16:59:21,227 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:59:21 INFO - 2015-11-20 16:59:21,227 DEBUG : BROWSER_OUTPUT: 16:59:21 INFO - 2015-11-20 16:59:21,819 INFO : Browser exited with error code: 0 16:59:21 INFO - 2015-11-20 16:59:21,862 INFO : Completed test kraken (00:00:57) 16:59:21 INFO - 2015-11-20 16:59:21,863 INFO : Starting test v8_7 16:59:21 INFO - 2015-11-20 16:59:21,863 DEBUG : operating with platform_type : mac_ 16:59:21 INFO - 2015-11-20 16:59:21,863 INFO : Initialising browser for v8_7 test... 16:59:21 INFO - 2015-11-20 16:59:21,875 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpBjDL7c/profile http://localhost:49262/getInfo.html 16:59:24 INFO - 2015-11-20 16:59:24,418 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:59:24 INFO - 2015-11-20 16:59:24,418 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:59:24 INFO - 2015-11-20 16:59:24,418 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:59:24 INFO - 2015-11-20 16:59:24,418 DEBUG : BROWSER_OUTPUT: __metrics 16:59:24 INFO - 2015-11-20 16:59:24,997 INFO : Browser initialized. 16:59:24 INFO - 2015-11-20 16:59:24,998 INFO : Running cycle 1/1 for v8_7 test... 16:59:24 INFO - 2015-11-20 16:59:24,998 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/T/tmpBjDL7c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:59:36 INFO - 2015-11-20 16:59:36,874 DEBUG : BROWSER_OUTPUT: RSS: Main: 237047808 16:59:36 INFO - 2015-11-20 16:59:36,875 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49262/tests/v8_7/run.html (next: http://localhost:49262/tests/v8_7/run.html) 16:59:58 INFO - 2015-11-20 16:59:58,474 DEBUG : BROWSER_OUTPUT: RSS: Main: 247791616 16:59:58 INFO - 2015-11-20 16:59:58,474 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: |0;Richards;147.4708745022858 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;158.27793605571384 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4691.588785046729 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: |4;RayTrace;944.2870632672333 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: |5;Earley;720.9805335255949 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: |6;Boyer;12512.5 16:59:58 INFO - 2015-11-20 16:59:58,476 DEBUG : BROWSER_OUTPUT: |7;RegExp;27324.324324324323 16:59:58 INFO - 2015-11-20 16:59:58,477 DEBUG : BROWSER_OUTPUT: |8;Splay;695.4102920723227 16:59:58 INFO - 2015-11-20 16:59:58,477 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4529.411764705882 16:59:58 INFO - 2015-11-20 16:59:58,477 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:59:58 INFO - 2015-11-20 16:59:58,477 DEBUG : BROWSER_OUTPUT: __startTimestamp1448067598475__endTimestamp 16:59:58 INFO - 2015-11-20 16:59:58,477 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,477 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:59:58 INFO - 2015-11-20 16:59:58,477 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:59:58 INFO - 2015-11-20 16:59:58,477 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,478 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.47 Median:147.47 stddev:0.00 (0.0%) 16:59:58 INFO - 2015-11-20 16:59:58,478 DEBUG : BROWSER_OUTPUT: Values: 147.5 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:158.28 Median:158.28 stddev:0.00 (0.0%) 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: Values: 158.3 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: Values: 279.4 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4691.59 Median:4691.59 stddev:0.00 (0.0%) 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: Values: 4691.6 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:944.29 Median:944.29 stddev:0.00 (0.0%) 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: Values: 944.3 16:59:58 INFO - 2015-11-20 16:59:58,479 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:720.98 Median:720.98 stddev:0.00 (0.0%) 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: Values: 721.0 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12512.50 Median:12512.50 stddev:0.00 (0.0%) 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: Values: 12512.5 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27324.32 Median:27324.32 stddev:0.00 (0.0%) 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: Values: 27324.3 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:695.41 Median:695.41 stddev:0.00 (0.0%) 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: Values: 695.4 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4529.41 Median:4529.41 stddev:0.00 (0.0%) 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: Values: 4529.4 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:59:58 INFO - 2015-11-20 16:59:58,480 DEBUG : BROWSER_OUTPUT: 16:59:59 INFO - 2015-11-20 16:59:59,063 INFO : Browser exited with error code: 0 16:59:59 INFO - 2015-11-20 16:59:59,081 INFO : Completed test v8_7 (00:00:37) 16:59:59 INFO - 2015-11-20 16:59:59,125 INFO : Completed test suite (00:20:05) 16:59:59 INFO - 2015-11-20 16:59:59,125 DEBUG : Working with test: dromaeo_css 16:59:59 INFO - 2015-11-20 16:59:59,125 DEBUG : Generating results file: dromaeo_css 16:59:59 INFO - 2015-11-20 16:59:59,126 DEBUG : Working with test: kraken 16:59:59 INFO - 2015-11-20 16:59:59,126 DEBUG : Generating results file: kraken 16:59:59 INFO - 2015-11-20 16:59:59,126 INFO : javascript benchmark 16:59:59 INFO - 2015-11-20 16:59:59,126 DEBUG : Working with test: v8_7 16:59:59 INFO - 2015-11-20 16:59:59,126 DEBUG : Generating results file: v8_7 16:59:59 INFO - 2015-11-20 16:59:59,127 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:59:59 INFO - 2015-11-20 16:59:59,619 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 16:59:59 INFO - 2015-11-20 16:59:59,619 DEBUG : process_Request line: dromaeo_css 7581.57 graph.html#tests=[[72,1,61]] 16:59:59 INFO - 2015-11-20 16:59:59,619 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:59:59 INFO - 2015-11-20 16:59:59,645 DEBUG : process_Request line: kraken 1541.60 graph.html#tests=[[232,1,61]] 16:59:59 INFO - 2015-11-20 16:59:59,646 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:59:59 INFO - 2015-11-20 16:59:59,672 DEBUG : process_Request line: v8_7 22103.73 graph.html#tests=[[230,1,61]] 16:59:59 INFO - 2015-11-20 16:59:59,673 INFO : javascript benchmark 16:59:59 INFO - 2015-11-20 16:59:59,675 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3103.705148010939, 3462.186386199243, 3523.330567192235, 3574.839132239049, 3576.2489877125804, 5688.288963879515, 5819.0, 5875.794347197849, 5880.353161152269, 5892.705364731757, 5802.738876750545, 5877.9412205877925, 5915.5859089863725, 6009.098635204721, 6121.418465245794, 5267.26258323835, 5321.4412486688925, 5391.029614669358, 5404.621676482648, 5449.6730196188155, 5437.157240627709, 5444.91832622511, 5457.836264912059, 5495.807646732365, 5567.693776842272, 5152.433232344439, 5223.373195216598, 5249.4488078751565, 5390.218418329359, 5397.568194544427, 5358.705271210082, 5367.194920761878, 5388.43421440747, 5410.756515956791, 5419.972900135514, 3955.703322250814, 5355.116405793039, 5370.087085195526, 5391.622586418952, 5395.622306438551, 4744.430668319824, 5547.25112109868, 5727.284089488814, 5809.302883653946, 5874.853128671774, 5562.9443705563235, 6312.368763123697, 6318.210223722035, 6331.588446750947, 6351.809445716636, 4775.0, 4838.758062096881, 6147.586055207283, 6265.59273647216, 6402.071699603532, 4996.925046124347, 5858.179854820329, 5927.318358388754, 5987.700614969234, 5988.131720900445, 6216.4405203531, 6533.967330163318, 6572.967135164294, 6584.111144995364, 6648.800535983928, 6107.401224262706, 6130.601510901866, 6136.917362303815, 6266.216722909637, 6267.62394256346, 6333.113364129025, 6340.239171299474, 6433.4209921106385, 6461.515386346043, 6462.4183823456115, 6287.0, 6291.1192433059405, 6334.429901308904, 6349.206349206349, 6351.682415879188, 5188.481151884781, 6145.600535965237, 6261.186045814015, 6290.4653104485715, 6326.810195694136, 5117.309163262912, 5119.257707632372, 5131.076406246912, 5148.56237219833, 5149.407818100892, 4633.930491042637, 4655.2784318430695, 4665.323528088476, 4678.157931572349, 4690.9765451172525, 5838.036723940587, 5847.1229315603, 5930.406959304035, 6002.759889604367, 6078.45293923549, 6350.0944121966095, 6431.099646049557, 6438.291787903327, 6465.967670161619, 6469.482441404771, 5863.091220860773, 6111.899858025598, 6117.785877494266, 6121.47967422774, 6122.051082082285, 5489.176623506426, 5509.752061157257, 5530.391656917735, 5540.390557038722, 5574.0, 6335.429811317003, 6337.144485494584, 6341.619502829845, 6352.269489008823, 6357.841053973502, 6139.693015349304, 6163.630182189083, 6187.226596675416, 6415.935840641534, 6425.839354016187, 5154.458781827854, 6207.255129384503, 6222.657753823402, 6258.718357673824, 6305.0, 5392.51467367923, 6250.781222657185, 6279.340669229665, 6314.557980941474, 6334.8733025338315, 6155.692215389302, 6181.690915454119, 6274.0, 6325.272593651789, 6332.905006425, 6246.344133865879, 6264.185655864709, 6267.0599410087025, 6275.058741188858, 6288.685565721604, 6269.404406581368, 6272.40412160844, 6274.780382686584, 6284.5600807943, 6295.1186833842385, 5983.431574000463, 6102.1762062122825, 6121.204243448323, 6144.556029333014, 6244.594101383395, 6104.639565963084, 6194.318624951162, 6279.497640188865, 6282.371762823864, 6284.465820405134, 6264.310925798068, 6299.149614801943, 6302.779402720883, 6313.715882785194, 6315.810525684236], "unit": "ms", "name": "dojo.html", "value": 5792.390127242596}, {"lowerIsBetter": false, "replicates": [548.8414715257693, 572.153213244398, 572.8682403047301, 592.9149656129284, 635.7043974551832, 27820.0, 28765.280867978287, 37689.68086116983, 39044.609553904455, 39264.80367598165, 43168.56831431685, 43297.7835110824, 43374.7831260844, 43463.0, 43598.34602480965, 9877.90122098777, 9951.402915825074, 10035.34770239932, 10042.0, 10051.748706282366, 9807.41155530667, 9894.90105098947, 9903.55434005468, 9916.454594997273, 9916.851247231298, 9780.266480013992, 9882.209423246159, 9888.604455821758, 9907.504624768733, 9914.206863450907, 9755.951220243924, 9867.703968880945, 9890.456024918627, 9902.950485247527, 9961.103500684936, 9775.0, 9896.356736812084, 9904.603815847357, 9908.653197138066, 9962.701118966443, 41495.58504414948, 41600.0, 41815.0, 41984.79007604942, 42117.0, 3136.7333776629016, 3152.7477801775804, 3373.8987830365127, 3414.3171365726707, 4041.595840415935, 24285.757142428527, 28505.572416413772, 28872.566911496346, 29510.11469655892, 29740.0, 2706.174616741893, 2835.6455443069617, 2856.7286107819723, 2859.070801989362, 2956.659984101834, 495850.0, 496276.0, 498732.0, 499950.0, 500793.0, 58394.41605583975, 59237.407625924054, 63099.0, 63731.0, 63896.041559376645, 71586.64206678934, 71955.64022179856, 72454.0, 72674.9098763519, 72985.6350718243, 14650.706985860223, 14668.193249371174, 14728.779068313985, 14785.482508112165, 14825.555233343017, 12872.93563532195, 12873.806892896613, 12974.675633109247, 13045.0, 13054.21674699502, 15995.12026838535, 19812.0, 19953.0, 20064.799352006587, 20084.69872951907, 8613.48319100856, 8821.470711757314, 8873.689420870238, 8879.778005549784, 8913.732588022369, 875.2341701011615, 900.9548923249, 1008.5476913244904, 1026.4918865161644, 1103.4096758234466, 28154.0, 28664.283392914927, 29856.55215171774, 30504.222097710855, 30856.920007799617, 1061.0874647802884, 1081.643057790927, 1090.9945450272699, 1136.4829002803704, 1207.7342984543386, 13882.652933676738, 14478.638034049232, 14610.853891460949, 14848.406063757544, 15889.967152135074, 721893.0, 726126.0, 731023.0, 732513.0, 733605.0, 58257.70871145617, 58923.70538147282, 58927.41072589305, 58988.0, 59065.40934590685, 1453.2152637575591, 1459.503768718662, 1485.6434455730546, 1493.7087267982856, 1504.0148702599815, 22651.773482264965, 25830.095946641777, 29927.0, 30234.84882575573, 31044.22389440282, 43668.0, 49838.750806245735, 49914.750426247636, 50084.0, 50139.0, 470552.0, 471097.0, 471239.0, 473356.0, 475741.0, 29085.418291634473, 30219.7912083523, 34106.31787364189, 34271.485927711605, 34398.248140149226, 42805.57194428016, 43549.346759799264, 43922.34116488192, 43925.0, 44584.77707611441, 36994.44508332323, 37896.242075158894, 38419.80790096144, 38529.0, 38637.0, 33361.0, 35354.46968295426, 36013.63986360103, 36546.0, 37440.251194975404, 37530.68642597496, 37583.0, 37914.43128353022, 38051.80974095112, 38087.428688570246, 33695.663043369255, 33733.0, 33914.98255052352, 33962.15094622654, 34199.65800342064, 24280.1501947431, 24299.392515186555, 24524.877375613007, 24850.254492365257, 25581.0], "unit": "ms", "name": "ext.html", "value": 20101.54614728415}, {"lowerIsBetter": false, "replicates": [355.42421277530406, 358.22265683466856, 366.37167258152294, 367.9908002299942, 370.0711214850724, 16181.919090404532, 19269.71095433568, 19393.515162120955, 20046.799532004676, 20479.180832766673, 14522.491712790055, 14551.417943282257, 14653.607907248821, 19162.71255931162, 19882.0, 5798.217240672508, 5910.527157827385, 5982.102684597302, 5987.251593550806, 5996.340402555716, 3773.792441415721, 3907.33575292201, 4609.239475486541, 5702.54379649627, 5989.580729348925, 5620.409856965021, 5669.603127781057, 5705.65766054036, 5709.543236541067, 5709.886572118438, 5594.328680558338, 6297.118403423525, 6319.8736025279695, 6344.080108384258, 6372.299047104815, 5504.4770746778995, 5521.668699878021, 5544.085225937715, 5546.251256080418, 5573.024720673866, 12243.816342754866, 12449.066320025944, 12690.11169218155, 12705.618831435071, 12719.0, 1895.924163033477, 1984.9305274315475, 2057.341650671786, 2085.95828083439, 2174.521605246843, 9492.667756628554, 9606.0, 9786.168175705003, 9927.751806204902, 9943.254255930835, 1643.6301832087804, 1746.772919520467, 1753.6229710612151, 1795.0306834309458, 1801.8378345948927, 58850.528736781496, 59971.700141499015, 100461.0, 105138.0, 105877.0, 10658.78682426347, 10940.070094042096, 10957.561697532168, 11012.119030477543, 11096.389698566494, 13040.869591303965, 13099.345032748324, 13133.737325253442, 13156.736865262641, 13208.0, 8509.446885952393, 8546.78633034179, 8577.228049475578, 8584.613692383859, 8585.570721463902, 7325.963370183115, 8746.95626521876, 8778.868316975251, 8800.251978581764, 8926.214757048616, 4231.428757117811, 4287.957120428819, 4323.654107671378, 4395.077033822869, 4407.955920440819, 1572.2138930534732, 1579.676166385888, 1735.496705955259, 1777.8844375115575, 1852.8147185281364, 386.0637952964051, 391.3698944699032, 391.64947372101807, 408.84463903716994, 1007.7178390050798, 8494.490330580185, 10888.237823352447, 11315.207935444605, 11487.195896287347, 11684.70788230301, 432.9675274354436, 437.43133925896205, 449.59536417224103, 923.7505873414141, 944.6221511395497, 10340.27618066728, 10515.52680129396, 10584.576616935236, 10650.094741946867, 10828.78342433147, 745437.0, 751888.0, 762067.0, 763203.0, 768875.2449902053, 112718.43640781744, 116520.41739791246, 117729.0, 118130.0, 118352.0, 1251.8310028146266, 1253.129075292663, 1254.1095821966323, 1255.29076072019, 1275.9170653907465, 17266.22301996388, 17285.135743212537, 17381.56546086358, 17455.669674043947, 17473.38843140484, 37232.06919827026, 45130.54869451395, 48721.756391217816, 49794.00411991667, 51013.0, 65874.35314116994, 66023.0, 67870.66064669644, 69170.65414673096, 69417.65291173512, 9658.3722058066, 9771.267154963263, 9920.206383489447, 10007.849882251918, 10011.749706257402, 15004.0, 17304.480865574053, 19421.0, 19824.10791514414, 19833.20667173297, 14062.367193476523, 15534.378624854879, 15549.0, 15822.287997040392, 16033.67932641364, 11461.598844040753, 14314.783243424426, 15832.841671583597, 15941.36234550605, 16281.511554652905, 16272.837271627606, 16286.18569071518, 16534.33862645529, 16800.495985120466, 16947.237374318433, 9730.36752611078, 9842.852357214791, 9935.751606209902, 10116.08955194036, 10176.338537995007, 15323.233838308262, 15775.842241577437, 16091.597710057342, 16253.106079165287, 16392.18039098064], "unit": "ms", "name": "jquery.html", "value": 9179.62944325007}, {"lowerIsBetter": false, "replicates": [1561.656435584171, 1599.1284749811352, 1924.5573518090844, 1950.434374031531, 1970.3793305108888, 7409.0, 7512.699492020312, 8452.830943381128, 8843.602037908293, 8884.378093533447, 8284.33725301976, 8437.957810210955, 8520.744377668665, 8527.317814574835, 8551.572421378922, 2365.881705914706, 2404.4229384947575, 2411.3248290478696, 2416.830821842472, 2419.080749315258, 2411.2886698423918, 2441.841280316774, 2446.7675570820743, 2452.141750387368, 2461.507698460306, 2358.3868194269444, 2385.9642105368434, 2402.0631953538136, 2415.1667674652217, 2423.660687503751, 2361.7874391304863, 2405.891734871926, 2407.0853075831246, 2417.721961974378, 2420.1529464687396, 2392.964105538418, 2434.415740222352, 2448.9142879999295, 2451.117597664839, 2458.766417190364, 8437.704680336159, 8514.020887597944, 8516.74449766508, 8523.0, 8535.359848011361, 4631.374764406795, 5152.768125434364, 5226.52961233487, 5252.474752524717, 5264.499872512105, 3189.6331921829055, 3495.2834668892815, 3507.228409749851, 3563.394222982073, 3572.428411454181, 1024.8257796174669, 1039.4646756920192, 1042.7653777899989, 1072.447689439939, 1073.4954571351452, 11189.16081293898, 11252.38111903845, 11269.549218031269, 11277.774444511064, 11290.717732056764, 4715.528447155257, 4750.216214324667, 4861.440934292531, 4876.683015603974, 4879.682820616648, 9707.223422126213, 9775.90224097764, 9794.020597940149, 9803.0, 9816.165625921876, 5278.996990571779, 5322.121849894801, 5325.627206095536, 5350.38470575881, 5370.275012873212, 4816.157172494799, 4837.93565415608, 4868.586170175575, 4873.488283730228, 4892.143874821892, 3861.3242682530445, 3916.804159792056, 3936.488256526633, 3949.0, 3950.4271880577157, 1297.0, 1300.14840279617, 1304.2239867278954, 1306.372940988312, 1318.6241921052454, 1389.7359501694646, 1393.261571367177, 1407.1486750515994, 1410.4851729119002, 1432.2480697633825, 7045.225025247219, 8074.919250807534, 8128.431009829374, 8128.471649342892, 8142.552159631158, 489.6988352163394, 494.99752501237265, 497.9676321039121, 498.36209651645953, 498.4492136189531, 5850.736716847752, 6148.661823599745, 6182.412670796267, 6202.2867370253, 6229.0967809667345, 9331.906680933103, 10022.997700230064, 10283.920188380262, 10383.584656613652, 10403.687889363331, 8345.66617335312, 9963.501824908726, 10216.489175541343, 10217.540210690537, 10296.176305895511, 6907.516473846783, 8021.5187088774865, 8023.876657267987, 8120.431569790058, 8190.631421585924, 7638.427117966064, 7692.92307076922, 7710.92289077102, 7715.305622494003, 7753.844923101394, 9104.726858194264, 9136.08639136081, 9281.303902207497, 9297.209737172145, 9305.348625596143, 9320.906790932275, 9379.108984646447, 9420.764480888032, 9559.044095590385, 9605.03949605034, 7299.452541059336, 7316.0489136411925, 7326.120865496175, 7343.44924130703, 7353.301436363537, 8149.8370032600205, 8156.0620528639965, 8199.631016604148, 8222.259996600334, 8237.423380363318, 7552.980347652997, 7641.159472457914, 7655.923440765521, 7669.0, 7701.961490192513, 7307.3423391894985, 7350.742724004848, 7488.438367122597, 7539.095308563007, 7569.053868266466, 7629.847403051797, 7702.807429814299, 7709.113451953097, 7721.03487064117, 7740.303372696484, 6917.550359226634, 6977.058097156819, 6987.336203060904, 7000.789976300719, 7020.403265722471, 7072.151341839012, 7091.716331346688, 7110.253423390676, 7119.252478489684, 7126.536775109601], "unit": "ms", "name": "mootools.html", "value": 4768.909480853552}, {"lowerIsBetter": false, "replicates": [271.7404878341184, 278.8844621513944, 321.5883668903803, 331.51929701932204, 332.51286864743145, 6853.862922741542, 6870.278620744824, 6885.931140688592, 7024.789256322312, 7047.1895731990835, 6781.627010514419, 6877.793666190022, 6912.481563882704, 6916.170059592856, 6927.653617319126, 4871.269309603553, 4972.751362431882, 5073.619478539106, 5086.440491545945, 5104.183330667103, 4063.634272915437, 4943.876403089916, 4994.375703037121, 5008.198688209887, 5052.873678158038, 4941.382327209099, 4956.7769450374635, 4966.453690094105, 4977.950220497785, 5010.849674509753, 5002.7248501332415, 5004.374453193351, 5016.874578135539, 5031.471695471978, 5041.722705251228, 3673.7244706647107, 4120.484939382577, 4189.72766770159, 4233.0, 4249.936250956238, 5473.562115030788, 6313.210848643919, 6363.7454501819875, 6516.1203237562795, 6548.869022619521, 5766.4233576642, 5804.477597016289, 5807.245058142415, 5831.358550559435, 5854.76580936762, 7089.645517724145, 7255.782326530212, 7269.236730143364, 7276.308750668678, 7313.268673132698, 3884.242572698325, 4668.043051174535, 4672.112298663277, 4689.929651055237, 4691.225947718656, 6216.813495595139, 7678.0, 7759.224077592252, 7810.258025487569, 7812.960935195288, 4748.810047598126, 4763.166445872028, 4764.6426518011285, 4766.833160839354, 4768.47546769855, 4714.528547145258, 4821.373221481185, 4824.204006338915, 4847.3698419205275, 4871.732054737024, 5769.394213607595, 5847.1229315603, 5849.303701926478, 5849.707514624251, 5861.238039054895, 7385.9630701846145, 7393.926060739432, 7408.148062972827, 7417.629118544051, 7457.142428620778, 1637.9918100409423, 1664.5172899859147, 1688.4596928982853, 1693.7120689482817, 1696.2706036404218, 1029.5933106423072, 1065.3661071662348, 1081.118888106191, 1081.5403453532217, 1086.435053772034, 6660.034295027194, 6804.523683342119, 6841.315868413219, 6851.2121106072445, 6874.2094659113845, 6166.568340216142, 7606.505577137468, 7758.340541054074, 7759.806004849924, 7766.844663106706, 6900.930990690129, 6921.2732663069655, 6922.8615427692175, 6936.237013928464, 6960.791176264619, 3398.813065281384, 3910.550286717007, 4036.59634036594, 4050.18996200761, 4072.633462988286, 7630.2751238632245, 7646.923530764732, 7676.270754278335, 7698.884516732253, 7701.884471732817, 7902.960485197537, 7918.089419716691, 7928.286454219148, 7944.523328600302, 7950.840983180304, 7471.887921681179, 7693.961530192425, 7746.883796743054, 7784.961075194701, 7793.454458187985, 6396.488280937607, 7570.015897933234, 7719.768406947801, 7744.65149068282, 7754.573498457639, 6271.529635277281, 7314.780556583311, 7555.848883022419, 7558.962205188939, 7567.583782891994, 7721.227877212234, 7728.0, 7737.806554835949, 7738.303552680286, 7740.612969351398, 4732.47942726293, 4774.40319960005, 4778.976105119591, 4788.784504697227, 4796.784144713426, 7477.9530865679935, 7664.271894170045, 7683.308502234826, 7705.1524332324525, 7733.7679869604, 7355.77932662021, 7371.152317483344, 7372.48392612512, 7382.704691812267, 7414.073240844895, 6074.969625151846, 7368.189499154982, 7423.628818558943, 7431.033965584439, 7432.293932076444, 6925.445964322943, 7104.7513337035025, 7203.0, 7204.423646108194, 7209.963950180216, 7187.928120718726, 7195.208527062124, 7290.817729556804, 7363.705451781869, 7378.483506154517, 7260.782176534713, 7273.781786546412, 7286.344229019413, 7303.379212766762, 7313.268673132644], "unit": "ms", "name": "prototype.html", "value": 5290.092875293486}, {"lowerIsBetter": false, "replicates": [727.210976090941, 772.582805285146, 800.3757069485803, 815.1970309245393, 854.406187699549, 14871.330790114444, 15257.389704411838, 15355.539333819976, 15372.38510459583, 15401.075935443867, 16009.83990160098, 16338.101404422752, 16361.0, 16368.590785230375, 16420.589485262844, 761.2463660975621, 771.7183228121751, 960.8510680844463, 983.3509883476906, 984.6849008317341, 948.5257371314343, 968.7771812483134, 969.8787651543557, 980.0738302304289, 981.7300242433316, 999.7850462150636, 1004.3271008424373, 1009.7828966772142, 1010.1615659003047, 1011.3022014809758, 992.7319623701596, 997.436448406648, 1001.2840818814547, 1003.7691330993912, 1005.6178652112224, 731.9414446844239, 735.5770432001567, 737.6827963975488, 741.9258074192592, 742.9814254643624, 15420.151891645955, 15542.0, 15561.066336019874, 15629.921850390789, 15707.371705131782, 12363.62909112728, 12482.375881205904, 12501.874981250163, 12707.555235566802, 13128.146670466389, 9930.404175749478, 10253.43606101664, 10486.790264194673, 10700.357978521313, 11041.779164416666, 3395.8302084895904, 3476.217850983534, 3574.3566158091535, 3575.6424357564297, 3579.6599323064265, 77630.6118469404, 77810.0, 78061.60969195118, 78089.0, 78434.0, 8400.621972011275, 9257.259419246444, 9260.259179265642, 9316.20812230968, 9442.339036267394, 20839.791602083784, 20942.685859712117, 21060.578788424147, 21100.47248818792, 21108.894455527625, 6884.414824739853, 7265.200827908926, 7340.816479588053, 7439.888401673979, 7617.390608751287, 3556.928861422757, 4173.0, 4216.219999300078, 4217.5782421758195, 4223.598758117974, 3508.8771892983623, 3519.1729943463265, 3538.327717733622, 3543.7165026797793, 3564.3584154851856, 628.8930881750022, 639.8528338482082, 641.788209890735, 649.3636236488268, 649.4317472211815, 591.73371982608, 604.114971566657, 610.2402508876388, 614.4040280927583, 621.0808004153878, 7979.760607181794, 8149.714759983491, 8219.178082191853, 8599.785005374915, 8766.517841518778, 518.3883018038675, 552.6987791653559, 619.3651507205151, 621.8165641135876, 631.7157279224275, 3804.391297392404, 4070.9389359159636, 4078.9796051019557, 4100.036491424513, 4124.670026397881, 93334.0, 93960.53019734994, 96617.0, 97378.0, 98180.50909745549, 71366.0, 72289.27710722825, 73322.0, 73951.63024184844, 82341.17658823455, 71104.28895710976, 72091.0, 73116.0, 73447.53104937979, 74953.62523187349, 7380.557166570023, 7647.005889234587, 8936.642534298555, 8945.776355591162, 9032.277417806692, 53000.46999530109, 53019.46980530299, 53448.73275633597, 54190.0, 54918.725406372716, 71708.0, 74438.25561744314, 74478.51042979001, 75567.62216188884, 75876.0, 10837.512311945824, 11010.944945275221, 11145.944270278922, 11299.265547739371, 11736.413179340829, 11646.24299420535, 11692.123090768056, 11708.941455292668, 12142.150049496804, 12674.746505070032, 11106.555737770723, 11276.3797991108, 11548.94225528867, 11568.710782230512, 11779.528818847493, 11192.664220073411, 11216.046636036028, 11262.774744505228, 11556.306621602731, 12213.389330533615, 9244.352895297265, 10618.52216650268, 10919.454027298445, 11144.164187686118, 11525.596604118815, 9375.824328965018, 9381.859272110787, 9637.18083962871, 9695.70912872615, 9866.753331166778, 7664.961675191588, 8547.871781923152, 9619.691274094306, 9936.403815771077, 9997.100260976547], "unit": "ms", "name": "yui.html", "value": 7042.486623756694}], "name": "dromaeo_css", "value": 7581.57275807912}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 115.0, 123.0, 149.0, 125.0, 118.0, 111.0, 94.0, 169.0], "unit": "ms", "name": "ai-astar", "value": 122.5}, {"lowerIsBetter": true, "replicates": [143.0, 141.0, 175.0, 157.0, 125.0, 171.0, 171.0, 149.0, 158.0, 150.0], "unit": "ms", "name": "audio-beat-detection", "value": 154.0}, {"lowerIsBetter": true, "replicates": [191.0, 189.0, 191.0, 204.0, 223.0, 193.0, 203.0, 203.0, 205.0, 201.0], "unit": "ms", "name": "audio-dft", "value": 200.3}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 58.0, 69.0, 102.0, 56.0, 55.0, 59.0, 58.0, 109.0], "unit": "ms", "name": "audio-fft", "value": 68.3}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 105.0, 85.0, 113.0, 116.0, 93.0, 59.0, 74.0, 123.0], "unit": "ms", "name": "audio-oscillator", "value": 92.1}, {"lowerIsBetter": true, "replicates": [131.0, 130.0, 91.0, 86.0, 87.0, 86.0, 86.0, 91.0, 86.0, 121.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 99.5}, {"lowerIsBetter": true, "replicates": [95.0, 103.0, 152.0, 113.0, 150.0, 98.0, 101.0, 152.0, 152.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 121.0}, {"lowerIsBetter": true, "replicates": [82.0, 106.0, 116.0, 101.0, 94.0, 141.0, 83.0, 142.0, 151.0, 145.0], "unit": "ms", "name": "imaging-desaturate", "value": 116.1}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 58.0, 61.0, 58.0, 60.0, 60.0, 67.0, 59.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 65.0, 65.0, 67.0, 85.0, 92.0, 102.0, 60.0, 101.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 76.8}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 84.0, 85.0, 83.0, 82.0, 84.0, 99.0, 110.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.2}, {"lowerIsBetter": true, "replicates": [133.0, 126.0, 126.0, 126.0, 119.0, 119.0, 150.0, 142.0, 109.0, 134.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [132.0, 183.0, 152.0, 137.0, 156.0, 141.0, 138.0, 140.0, 176.0, 126.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1541.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.4708745022858], "unit": "score", "name": "Richards", "value": 239.3828619999999}, {"lowerIsBetter": false, "replicates": [158.27793605571384], "unit": "score", "name": "DeltaBlue", "value": 417.7335239999998}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [4691.588785046729], "unit": "score", "name": "Decrypt", "value": 56.735790836653344}, {"lowerIsBetter": false, "replicates": [944.2870632672333], "unit": "score", "name": "RayTrace", "value": 783.6483509999999}, {"lowerIsBetter": false, "replicates": [720.9805335255949], "unit": "score", "name": "Earley", "value": 924.3841810000001}, {"lowerIsBetter": false, "replicates": [12512.5], "unit": "score", "name": "Boyer", "value": 53.26377622377621}, {"lowerIsBetter": false, "replicates": [27324.324324324323], "unit": "score", "name": "RegExp", "value": 33.33970820969339}, {"lowerIsBetter": false, "replicates": [695.4102920723227], "unit": "score", "name": "Splay", "value": 117.18405799999998}, {"lowerIsBetter": false, "replicates": [4529.411764705882], "unit": "score", "name": "NavierStokes", "value": 327.63636363636374}], "name": "v8_7", "value": 22103.728100369386}]} 16:59:59 INFO - RETURN: dromaeo_css: 7581.57 16:59:59 INFO - RETURN: kraken: 1541.60 16:59:59 INFO - RETURN: v8_7: 22103.73 16:59:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,61]]", "result": "22103.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1541.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7581.57"}}} 16:59:59 INFO - Return code: 0 16:59:59 INFO - # TBPL SUCCESS # 16:59:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:59:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:59:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:59:59 INFO - 2015-11-20 16:59:59.744 screenresolution[1685:11238] starting screenresolution argv=screenresolution get 16:59:59 INFO - 2015-11-20 16:59:59.746 screenresolution[1685:11238] Display 0: 1600x1200x32@60 16:59:59 INFO - 2015-11-20 16:59:59.752 screenresolution[1686:11241] starting screenresolution argv=screenresolution list 16:59:59 INFO - Available Modes on Display 0 16:59:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:59:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:59:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:59:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:59:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:59:59 INFO - Intel Iris: 16:59:59 INFO - Chipset Model: Intel Iris 16:59:59 INFO - Type: GPU 16:59:59 INFO - Bus: Built-In 16:59:59 INFO - VRAM (Dynamic, Max): 1536 MB 16:59:59 INFO - Vendor: Intel (0x8086) 16:59:59 INFO - Device ID: 0x0a2e 16:59:59 INFO - Revision ID: 0x0009 16:59:59 INFO - Displays: 16:59:59 INFO - Display: 16:59:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:59:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:59:59 INFO - Display Serial Number: 1600x1200 60 16:59:59 INFO - Main Display: Yes 16:59:59 INFO - Mirror: Off 16:59:59 INFO - Online: Yes 16:59:59 INFO - Rotation: Supported 16:59:59 INFO - Return code: 0 16:59:59 INFO - Running post-action listener: _resource_record_post_action 16:59:59 INFO - Running post-run listener: _resource_record_post_run 17:00:01 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 33652224; Write bytes: 693908992; Read time: 349; Write time: 2209 17:00:01 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334158336; Write bytes: 334972928; Read time: 26630; Write time: 684 17:00:01 INFO - run-tests - Wall time: 1208s; CPU: 53.0%; Read bytes: 32726528; Write bytes: 347459072; Read time: 336; Write time: 1490 17:00:01 INFO - Running post-run listener: _upload_blobber_files 17:00:01 INFO - Blob upload gear active. 17:00:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:00:01 INFO - Copying logs to upload dir... 17:00:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.650039 ========= master_lag: 3.83 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-20 17:00:04.905325) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 17:00:04.908787) ========= 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.1wBvGe8y4P/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.T2HzdeTmTs/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/06ymnJYlSiKZwjG0fGSv8A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009561 build_url: 'https://queue.taskcluster.net/v1/task/06ymnJYlSiKZwjG0fGSv8A/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-20 17:00:04.943185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 17:00:04.943590) ========= 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.1wBvGe8y4P/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.T2HzdeTmTs/Listeners TMPDIR=/var/folders/2y/lpbyjybx41n9034w0fnrskpc00000w/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:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004999 ========= master_lag: 0.53 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 17:00:05.475052) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 17:00:05.475504) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 17:00:05.479557) ========= ========= Total master_lag: 4.52 =========