builder: mozilla-inbound_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0090 starttime: 1447787329.15 results: success (0) buildid: 20151117093002 builduid: 56c9242244d04739be1718c3bba69c0d revision: 06188c6531b5b06fc9bd2cdcd25eaf5c1b778882 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:49.151105) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:49.151520) ========= ========= Started set props: basedir (results: 0, elapsed: 3 secs) (at 2015-11-17 11:08:49.151816) ========= 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.Y9ahx9bEcP/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.iD34s3jT4B/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006563 basedir: '/builds/slave/test' ========= master_lag: 3.22 ========= ========= Finished set props: basedir (results: 0, elapsed: 3 secs) (at 2015-11-17 11:08:52.375650) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:52.376127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:52.414112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:52.414410) ========= 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.Y9ahx9bEcP/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.iD34s3jT4B/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005620 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:52.464007) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:52.464388) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:52.464792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:52.465176) ========= 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.Y9ahx9bEcP/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.iD34s3jT4B/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-17 11:08:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.68M=0.002s 2015-11-17 11:08:52 (7.68 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.199709 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:52.802696) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:52.803007) ========= 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.Y9ahx9bEcP/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.iD34s3jT4B/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.022517 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:52.842076) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 11:08:52.842494) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 06188c6531b5b06fc9bd2cdcd25eaf5c1b778882 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 06188c6531b5b06fc9bd2cdcd25eaf5c1b778882 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y9ahx9bEcP/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.iD34s3jT4B/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-17 11:08:52,925 truncating revision to first 12 chars 2015-11-17 11:08:52,925 Setting DEBUG logging. 2015-11-17 11:08:52,925 attempt 1/10 2015-11-17 11:08:52,925 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/06188c6531b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 11:08:53,686 unpacking tar archive at: mozilla-inbound-06188c6531b5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.032095 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 11:08:53.892446) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:53.892782) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:53.906912) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:53.907293) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 11:08:53.907724) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-17 11:08:53.908072) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Y9ahx9bEcP/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.iD34s3jT4B/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 11:08:54 INFO - MultiFileLogger online at 20151117 11:08:54 in /builds/slave/test 11:08:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:08:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:08:54 INFO - {'append_to_log': False, 11:08:54 INFO - 'base_work_dir': '/builds/slave/test', 11:08:54 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:08:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:08:54 INFO - 'branch': 'Mozilla-Inbound', 11:08:54 INFO - 'buildbot_json_path': 'buildprops.json', 11:08:54 INFO - 'config_files': ('talos/mac_config.py',), 11:08:54 INFO - 'default_actions': ('clobber', 11:08:54 INFO - 'read-buildbot-config', 11:08:54 INFO - 'download-and-extract', 11:08:54 INFO - 'populate-webroot', 11:08:54 INFO - 'create-virtualenv', 11:08:54 INFO - 'install', 11:08:54 INFO - 'run-tests'), 11:08:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:08:54 INFO - 'download_minidump_stackwalk': True, 11:08:54 INFO - 'download_symbols': 'ondemand', 11:08:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:08:54 INFO - 'tooltool.py': '/tools/tooltool.py', 11:08:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:08:54 INFO - '/tools/misc-python/virtualenv.py')}, 11:08:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:08:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:08:54 INFO - 'installer_path': 'installer.exe', 11:08:54 INFO - 'log_level': 'info', 11:08:54 INFO - 'log_name': 'talos', 11:08:54 INFO - 'log_to_console': True, 11:08:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:08:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:08:54 INFO - 'opt_config_files': (), 11:08:54 INFO - 'pip_index': False, 11:08:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:08:54 INFO - 'cmd': ('bash', 11:08:54 INFO - '-c', 11:08:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:08:54 INFO - 'enabled': True, 11:08:54 INFO - 'halt_on_failure': False, 11:08:54 INFO - 'name': 'check_screen_resolution'},), 11:08:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:08:54 INFO - 'cmd': ('bash', 11:08:54 INFO - '-c', 11:08:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:08:54 INFO - 'enabled': True, 11:08:54 INFO - 'halt_on_failure': False, 11:08:54 INFO - 'name': 'check_screen_resolution'},), 11:08:54 INFO - 'run_cmd_checks_enabled': True, 11:08:54 INFO - 'sps_profile': False, 11:08:54 INFO - 'sps_profile_interval': 0, 11:08:54 INFO - 'suite': 'dromaeojs-e10s', 11:08:54 INFO - 'system_bits': '64', 11:08:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:08:54 INFO - 'title': 't-yosemite-r5-0090', 11:08:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:08:54 INFO - 'use_talos_json': True, 11:08:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:08:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:08:54 INFO - 'work_dir': 'build'} 11:08:54 INFO - ##### 11:08:54 INFO - ##### Running clobber step. 11:08:54 INFO - ##### 11:08:54 INFO - Running pre-action listener: _resource_record_pre_action 11:08:54 INFO - Running main action method: clobber 11:08:54 INFO - rmtree: /builds/slave/test/build 11:08:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:08:55 INFO - Running post-action listener: _resource_record_post_action 11:08:55 INFO - ##### 11:08:55 INFO - ##### Running read-buildbot-config step. 11:08:55 INFO - ##### 11:08:55 INFO - Running pre-action listener: _resource_record_pre_action 11:08:55 INFO - Running main action method: read_buildbot_config 11:08:55 INFO - Using buildbot properties: 11:08:55 INFO - { 11:08:55 INFO - "properties": { 11:08:55 INFO - "buildnumber": 208, 11:08:55 INFO - "product": "firefox", 11:08:55 INFO - "script_repo_revision": "production", 11:08:55 INFO - "builddir": "mozilla-inbound_yosemite_test-dromaeojs-e10s", 11:08:55 INFO - "repository": "", 11:08:55 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-inbound talos dromaeojs-e10s", 11:08:55 INFO - "buildid": "20151117093002", 11:08:55 INFO - "slavename": "t-yosemite-r5-0090", 11:08:55 INFO - "pgo_build": "False", 11:08:55 INFO - "basedir": "/builds/slave/test", 11:08:55 INFO - "project": "", 11:08:55 INFO - "platform": "yosemite", 11:08:55 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 11:08:55 INFO - "slavebuilddir": "test", 11:08:55 INFO - "scheduler": "tests-mozilla-inbound-macosx64-talos", 11:08:55 INFO - "branch": "mozilla-inbound", 11:08:55 INFO - "repo_path": "integration/mozilla-inbound", 11:08:55 INFO - "stage_platform": "macosx64", 11:08:55 INFO - "builduid": "56c9242244d04739be1718c3bba69c0d", 11:08:55 INFO - "revision": "06188c6531b5b06fc9bd2cdcd25eaf5c1b778882" 11:08:55 INFO - }, 11:08:55 INFO - "sourcestamp": { 11:08:55 INFO - "repository": "", 11:08:55 INFO - "hasPatch": false, 11:08:55 INFO - "project": "", 11:08:55 INFO - "branch": "mozilla-inbound-macosx64-talos", 11:08:55 INFO - "changes": [ 11:08:55 INFO - { 11:08:55 INFO - "category": null, 11:08:55 INFO - "files": [ 11:08:55 INFO - { 11:08:55 INFO - "url": null, 11:08:55 INFO - "name": "https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 11:08:55 INFO - } 11:08:55 INFO - ], 11:08:55 INFO - "repository": "", 11:08:55 INFO - "rev": "06188c6531b5b06fc9bd2cdcd25eaf5c1b778882", 11:08:55 INFO - "who": "wlachance@mozilla.com", 11:08:55 INFO - "when": 1447786999, 11:08:55 INFO - "number": 6673141, 11:08:55 INFO - "comments": "Bug 1222588 - Fix counter ingestion in Perfherder;r=jmaher", 11:08:55 INFO - "project": "", 11:08:55 INFO - "at": "Tue 17 Nov 2015 11:03:19", 11:08:55 INFO - "branch": "mozilla-inbound-macosx64-talos", 11:08:55 INFO - "revlink": "", 11:08:55 INFO - "properties": [ 11:08:55 INFO - [ 11:08:55 INFO - "buildid", 11:08:55 INFO - "20151117093002", 11:08:55 INFO - "Change" 11:08:55 INFO - ], 11:08:55 INFO - [ 11:08:55 INFO - "builduid", 11:08:55 INFO - "56c9242244d04739be1718c3bba69c0d", 11:08:55 INFO - "Change" 11:08:55 INFO - ], 11:08:55 INFO - [ 11:08:55 INFO - "pgo_build", 11:08:55 INFO - "False", 11:08:55 INFO - "Change" 11:08:55 INFO - ] 11:08:55 INFO - ], 11:08:55 INFO - "revision": "06188c6531b5b06fc9bd2cdcd25eaf5c1b778882" 11:08:55 INFO - } 11:08:55 INFO - ], 11:08:55 INFO - "revision": "06188c6531b5b06fc9bd2cdcd25eaf5c1b778882" 11:08:55 INFO - } 11:08:55 INFO - } 11:08:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 11:08:55 INFO - Running post-action listener: _resource_record_post_action 11:08:55 INFO - ##### 11:08:55 INFO - ##### Running download-and-extract step. 11:08:55 INFO - ##### 11:08:55 INFO - Running pre-action listener: _resource_record_pre_action 11:08:55 INFO - Running main action method: download_and_extract 11:08:55 INFO - mkdir: /builds/slave/test/build/tests 11:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:55 INFO - https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:08:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/test_packages.json 11:08:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/test_packages.json 11:08:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:08:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:08:56 INFO - Downloaded 1149 bytes. 11:08:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:08:56 INFO - Using the following test package requirements: 11:08:56 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:08:56 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:08:56 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 11:08:56 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:08:56 INFO - u'jsshell-mac.zip'], 11:08:56 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:08:56 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 11:08:56 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:08:56 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:08:56 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 11:08:56 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:08:56 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 11:08:56 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:08:56 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 11:08:56 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 11:08:56 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 11:08:56 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 11:08:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:08:56 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')]} 11:08:56 INFO - https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:08:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:08:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:08:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/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 11:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/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 11:08:57 INFO - Downloaded 17463434 bytes. 11:08:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 11:08:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:08:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:09:02 INFO - Return code: 0 11:09:02 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 11:09:02 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')]} 11:09:02 INFO - https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/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 11:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/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 11:09:03 INFO - Downloaded 17463434 bytes. 11:09:03 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 11:09:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 11:09:03 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 11:09:10 INFO - Return code: 0 11:09:10 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')]} 11:09:10 INFO - https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:09:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:09:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:09:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/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 11:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/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 11:09:11 INFO - Downloaded 11130997 bytes. 11:09:11 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 11:09:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 11:09:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 11:09:11 INFO - Return code: 0 11:09: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')]} 11:09:11 INFO - https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:09:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:09:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:09:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 11:09:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/vYXGVSLGTtq4oUua6c6MgA/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 11:09:17 INFO - Downloaded 108839448 bytes. 11:09:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:09:17 INFO - mkdir: /builds/slave/test/properties 11:09:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:09:17 INFO - Writing to file /builds/slave/test/properties/build_url 11:09:17 INFO - Contents: 11:09:17 INFO - build_url:https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 11:09:17 INFO - Running post-action listener: _resource_record_post_action 11:09:17 INFO - Running post-action listener: set_extra_try_arguments 11:09:17 INFO - ##### 11:09:17 INFO - ##### Running populate-webroot step. 11:09:17 INFO - ##### 11:09:17 INFO - Running pre-action listener: _resource_record_pre_action 11:09:17 INFO - Running main action method: populate_webroot 11:09:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:09:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:09:17 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:09:17 INFO - '../fennec_ids.txt'], 11:09:17 INFO - 'tests': ['tcheck2']}, 11:09:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:09:17 INFO - '--tppagecycles', 11:09:17 INFO - '7'], 11:09:17 INFO - 'tests': ['tsvgm']}}, 11:09:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:09:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:09:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:09:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:09:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:09:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:09:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:17 INFO - 'talos_options': ['--e10s'], 11:09:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:09:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:17 INFO - 'tests': ['damp', 'tps']}, 11:09:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:17 INFO - 'talos_options': ['--e10s'], 11:09:17 INFO - 'tests': ['damp', 'tps']}, 11:09:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:09:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:09:17 INFO - 'other': {'tests': ['a11yr', 11:09:17 INFO - 'ts_paint', 11:09:17 INFO - 'tpaint', 11:09:17 INFO - 'sessionrestore', 11:09:17 INFO - 'sessionrestore_no_auto_restore']}, 11:09:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:09:17 INFO - 'tests': ['a11yr', 11:09:17 INFO - 'ts_paint', 11:09:17 INFO - 'tpaint', 11:09:17 INFO - 'sessionrestore', 11:09:17 INFO - 'sessionrestore_no_auto_restore']}, 11:09:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:09:17 INFO - 'tests': ['a11yr', 11:09:17 INFO - 'ts_paint', 11:09:17 INFO - 'tpaint', 11:09:17 INFO - 'sessionrestore', 11:09:17 INFO - 'sessionrestore_no_auto_restore']}, 11:09:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:09:17 INFO - 'tests': ['a11yr', 11:09:17 INFO - 'ts_paint', 11:09:17 INFO - 'tpaint', 11:09:17 INFO - 'sessionrestore', 11:09:17 INFO - 'sessionrestore_no_auto_restore']}, 11:09:17 INFO - 'other_l64': {'tests': ['a11yr', 11:09:17 INFO - 'ts_paint', 11:09:17 INFO - 'tpaint', 11:09:17 INFO - 'sessionrestore', 11:09:17 INFO - 'sessionrestore_no_auto_restore']}, 11:09:17 INFO - 'other_nol64': {'tests': ['a11yr', 11:09:17 INFO - 'ts_paint', 11:09:17 INFO - 'tpaint', 11:09:17 INFO - 'sessionrestore', 11:09:17 INFO - 'sessionrestore_no_auto_restore']}, 11:09:17 INFO - 'svgr': {'tests': ['tsvgx', 11:09:17 INFO - 'tsvgr_opacity', 11:09:17 INFO - 'tart', 11:09:17 INFO - 'tscrollx', 11:09:17 INFO - 'cart']}, 11:09:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:09:17 INFO - 'tests': ['tsvgx', 11:09:17 INFO - 'tsvgr_opacity', 11:09:17 INFO - 'tart', 11:09:17 INFO - 'tscrollx', 11:09:17 INFO - 'cart']}, 11:09:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:17 INFO - 'tests': ['tp5o']}, 11:09:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:17 INFO - 'talos_options': ['--e10s'], 11:09:17 INFO - 'tests': ['tp5o']}, 11:09:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:17 INFO - 'talos_options': ['--xperf_path', 11:09:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:17 INFO - 'tests': ['tp5n']}, 11:09:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:09:17 INFO - 'talos_options': ['--e10s', 11:09:17 INFO - '--xperf_path', 11:09:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:09:17 INFO - 'tests': ['tp5n']}}, 11:09:17 INFO - 'talos.zip': {'path': '', 11:09:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:09:17 INFO - Running post-action listener: _resource_record_post_action 11:09:17 INFO - ##### 11:09:17 INFO - ##### Running create-virtualenv step. 11:09:17 INFO - ##### 11:09:17 INFO - Running pre-action listener: _resource_record_pre_action 11:09:17 INFO - Running main action method: create_virtualenv 11:09:17 INFO - Creating virtualenv /builds/slave/test/build/venv 11:09:17 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 11:09:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:09:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:09:17 INFO - Using real prefix '/tools/python27' 11:09:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:09:18 INFO - Installing distribute.............................................................................................................................................................................................done. 11:09:22 INFO - Installing pip.................done. 11:09:22 INFO - Return code: 0 11:09:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105217490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81ebe14f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513b9f0>, '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 0x104e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/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.iD34s3jT4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/Render', 11:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:22 INFO - 'HOME': '/Users/cltbld', 11:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:22 INFO - 'LOGNAME': 'cltbld', 11:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:22 INFO - 'MOZ_NO_REMOTE': '1', 11:09:22 INFO - 'NO_EM_RESTART': '1', 11:09:22 INFO - 'PAGER': '/bin/cat', 11:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:22 INFO - 'PWD': '/builds/slave/test', 11:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:22 INFO - 'SHELL': '/bin/bash', 11:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iD34s3jT4B/Listeners', 11:09:22 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 11:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:22 INFO - 'USER': 'cltbld', 11:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:22 INFO - 'XPC_FLAGS': '0x0', 11:09:22 INFO - 'XPC_SERVICE_NAME': '0', 11:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:22 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 11:09:22 INFO - Cleaning up... 11:09:22 INFO - Return code: 0 11:09:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105217490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81ebe14f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513b9f0>, '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 0x104e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/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.iD34s3jT4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:09:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/Render', 11:09:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:22 INFO - 'HOME': '/Users/cltbld', 11:09:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:22 INFO - 'LOGNAME': 'cltbld', 11:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:22 INFO - 'MOZ_NO_REMOTE': '1', 11:09:22 INFO - 'NO_EM_RESTART': '1', 11:09:22 INFO - 'PAGER': '/bin/cat', 11:09:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:22 INFO - 'PWD': '/builds/slave/test', 11:09:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:22 INFO - 'SHELL': '/bin/bash', 11:09:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iD34s3jT4B/Listeners', 11:09:22 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 11:09:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:22 INFO - 'USER': 'cltbld', 11:09:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:22 INFO - 'XPC_FLAGS': '0x0', 11:09:22 INFO - 'XPC_SERVICE_NAME': '0', 11:09:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:23 INFO - Downloading/unpacking psutil>=0.7.1 11:09:23 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 11:09:23 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 11:09:23 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 11:09:23 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 11:09:23 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 11:09:23 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 11:09:25 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:09:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:09:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:26 INFO - Installing collected packages: psutil 11:09:26 INFO - Running setup.py install for psutil 11:09:26 INFO - building 'psutil._psutil_osx' extension 11:09:26 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 11:09:26 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 11:09:26 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 11:09:26 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 11:09:26 INFO - building 'psutil._psutil_posix' extension 11:09:26 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 11:09:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:09:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:09:26 INFO - ^ 11:09:26 INFO - 1 warning generated. 11:09:26 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 11:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:09:27 INFO - Successfully installed psutil 11:09:27 INFO - Cleaning up... 11:09:27 INFO - Return code: 0 11:09:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:09:27 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')]} 11:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:27 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')]} 11:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:27 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 0x105217490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81ebe14f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513b9f0>, '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 0x104e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/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.iD34s3jT4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:27 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 11:09:27 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 11:09:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/Render', 11:09:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:27 INFO - 'HOME': '/Users/cltbld', 11:09:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:27 INFO - 'LOGNAME': 'cltbld', 11:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:27 INFO - 'MOZ_NO_REMOTE': '1', 11:09:27 INFO - 'NO_EM_RESTART': '1', 11:09:27 INFO - 'PAGER': '/bin/cat', 11:09:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:27 INFO - 'PWD': '/builds/slave/test', 11:09:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:27 INFO - 'SHELL': '/bin/bash', 11:09:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iD34s3jT4B/Listeners', 11:09:27 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 11:09:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:27 INFO - 'USER': 'cltbld', 11:09:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:27 INFO - 'XPC_FLAGS': '0x0', 11:09:27 INFO - 'XPC_SERVICE_NAME': '0', 11:09:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:09:27 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 11:09:27 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 11:09:27 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 11:09:27 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 11:09:27 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 11:09:27 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 11:09:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:09:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:09:30 INFO - Installing collected packages: mozsystemmonitor 11:09:30 INFO - Running setup.py install for mozsystemmonitor 11:09:30 INFO - Successfully installed mozsystemmonitor 11:09:30 INFO - Cleaning up... 11:09:30 INFO - Return code: 0 11:09:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:30 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 0x105217490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81ebe14f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513b9f0>, '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 0x104e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/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.iD34s3jT4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:30 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 11:09:30 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 11:09:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/Render', 11:09:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:30 INFO - 'HOME': '/Users/cltbld', 11:09:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:30 INFO - 'LOGNAME': 'cltbld', 11:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:30 INFO - 'MOZ_NO_REMOTE': '1', 11:09:30 INFO - 'NO_EM_RESTART': '1', 11:09:30 INFO - 'PAGER': '/bin/cat', 11:09:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:30 INFO - 'PWD': '/builds/slave/test', 11:09:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:30 INFO - 'SHELL': '/bin/bash', 11:09:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iD34s3jT4B/Listeners', 11:09:30 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 11:09:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:30 INFO - 'USER': 'cltbld', 11:09:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:30 INFO - 'XPC_FLAGS': '0x0', 11:09:30 INFO - 'XPC_SERVICE_NAME': '0', 11:09:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:30 INFO - Downloading/unpacking blobuploader==1.2.4 11:09:30 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 11:09:30 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 11:09:30 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 11:09:30 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 11:09:30 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 11:09:30 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 11:09:33 INFO - Downloading blobuploader-1.2.4.tar.gz 11:09:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:09:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:09:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:09:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:09:34 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 11:09:34 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 11:09:34 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 11:09:34 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 11:09:34 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 11:09:34 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 11:09:35 INFO - Downloading docopt-0.6.1.tar.gz 11:09:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:09:35 INFO - Installing collected packages: blobuploader, requests, docopt 11:09:35 INFO - Running setup.py install for blobuploader 11:09:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:09:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:09:35 INFO - Running setup.py install for requests 11:09:36 INFO - Running setup.py install for docopt 11:09:36 INFO - Successfully installed blobuploader requests docopt 11:09:36 INFO - Cleaning up... 11:09:36 INFO - Return code: 0 11:09:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:36 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 0x105217490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81ebe14f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513b9f0>, '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 0x104e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/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.iD34s3jT4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:36 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 11:09:36 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 11:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/Render', 11:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:36 INFO - 'HOME': '/Users/cltbld', 11:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:36 INFO - 'LOGNAME': 'cltbld', 11:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:36 INFO - 'MOZ_NO_REMOTE': '1', 11:09:36 INFO - 'NO_EM_RESTART': '1', 11:09:36 INFO - 'PAGER': '/bin/cat', 11:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:36 INFO - 'PWD': '/builds/slave/test', 11:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:36 INFO - 'SHELL': '/bin/bash', 11:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iD34s3jT4B/Listeners', 11:09:36 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 11:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:36 INFO - 'USER': 'cltbld', 11:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:36 INFO - 'XPC_FLAGS': '0x0', 11:09:36 INFO - 'XPC_SERVICE_NAME': '0', 11:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:36 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-w9ohEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:36 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-42i1oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:36 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-un_UVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:37 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-srPcXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:37 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-4ZN1m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:37 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-xLknmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:37 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Rrj03g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:37 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-u__G98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:37 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-E68WPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:37 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-37nZS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:38 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-kVEHsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:38 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-NAZCRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:38 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-gyhbBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:38 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-tdPphh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:38 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-Whqjfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:38 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-8FV7Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:38 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-9dsLtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:09:39 INFO - Running setup.py install for manifestparser 11:09:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:09:39 INFO - Running setup.py install for mozcrash 11:09:39 INFO - Running setup.py install for mozdebug 11:09:39 INFO - Running setup.py install for mozdevice 11:09:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:09:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:09:39 INFO - Running setup.py install for mozfile 11:09:40 INFO - Running setup.py install for mozhttpd 11:09:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:09:40 INFO - Running setup.py install for mozinfo 11:09:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:09:40 INFO - Running setup.py install for mozInstall 11:09:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:09:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:09:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:09:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:09:40 INFO - Running setup.py install for mozleak 11:09:40 INFO - Running setup.py install for mozlog 11:09:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:09:41 INFO - Running setup.py install for moznetwork 11:09:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:09:41 INFO - Running setup.py install for mozprocess 11:09:41 INFO - Running setup.py install for mozprofile 11:09:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:09:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:09:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:09:41 INFO - Running setup.py install for mozrunner 11:09:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:09:41 INFO - Running setup.py install for mozscreenshot 11:09:42 INFO - Running setup.py install for moztest 11:09:42 INFO - Running setup.py install for mozversion 11:09:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:09:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:09:42 INFO - Cleaning up... 11:09:42 INFO - Return code: 0 11:09:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09: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')]} 11:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09: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')]} 11:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:42 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 0x105217490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81ebe14f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513b9f0>, '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 0x104e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/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.iD34s3jT4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:42 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 11:09:42 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 11:09:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/Render', 11:09:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:42 INFO - 'HOME': '/Users/cltbld', 11:09:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:42 INFO - 'LOGNAME': 'cltbld', 11:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:42 INFO - 'MOZ_NO_REMOTE': '1', 11:09:42 INFO - 'NO_EM_RESTART': '1', 11:09:42 INFO - 'PAGER': '/bin/cat', 11:09:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:42 INFO - 'PWD': '/builds/slave/test', 11:09:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:42 INFO - 'SHELL': '/bin/bash', 11:09:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iD34s3jT4B/Listeners', 11:09:42 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 11:09:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:42 INFO - 'USER': 'cltbld', 11:09:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:42 INFO - 'XPC_FLAGS': '0x0', 11:09:42 INFO - 'XPC_SERVICE_NAME': '0', 11:09:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:09:42 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-bhIZpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:09:43 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)) 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:09:43 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-bxe4YJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:09:43 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)) 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:09:43 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-fcRJVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:09:43 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)) 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:09:43 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-YJhHJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:09:43 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)) 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:09:43 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-T0UkLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:09:43 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)) 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:09:43 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-vKdSsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:09:43 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)) 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:09:43 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-G26G4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:09:43 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)) 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:09:43 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-IdQHF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:09:43 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)) 11:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:09:43 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-L52L4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:09:44 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)) 11:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:09:44 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-eJ0DmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:09:44 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)) 11:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:09:44 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-KB0xcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:09:44 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)) 11:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:09:44 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-pzFS92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:09:44 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)) 11:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:09:44 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-15UxGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:09:44 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)) 11:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:09:44 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-GloBnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:09:44 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)) 11:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:44 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-HZv9GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:09:45 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)) 11:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:09:45 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-dwWIaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:09:45 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)) 11:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:09:45 INFO - Running setup.py (path:/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/pip-ibzw02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:09:45 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)) 11:09:45 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)) 11:09:45 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)) 11:09:45 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)) 11:09:45 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)) 11:09:45 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)) 11:09:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:09:45 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 11:09:45 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 11:09:45 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 11:09:45 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 11:09:45 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 11:09:45 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 11:09:47 INFO - Downloading blessings-1.5.1.tar.gz 11:09:48 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 11:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:09:48 INFO - Installing collected packages: blessings 11:09:48 INFO - Running setup.py install for blessings 11:09:48 INFO - Successfully installed blessings 11:09:48 INFO - Cleaning up... 11:09:48 INFO - Return code: 0 11:09:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:09:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:48 INFO - Reading from file tmpfile_stdout 11:09:48 INFO - Current package versions: 11:09:48 INFO - blessings == 1.5.1 11:09:48 INFO - blobuploader == 1.2.4 11:09:48 INFO - docopt == 0.6.1 11:09:48 INFO - manifestparser == 1.1 11:09:48 INFO - mozInstall == 1.12 11:09:48 INFO - mozcrash == 0.16 11:09:48 INFO - mozdebug == 0.1 11:09:48 INFO - mozdevice == 0.47 11:09:48 INFO - mozfile == 1.2 11:09:48 INFO - mozhttpd == 0.7 11:09:48 INFO - mozinfo == 0.9 11:09:48 INFO - mozleak == 0.1 11:09:48 INFO - mozlog == 3.0 11:09:48 INFO - moznetwork == 0.27 11:09:48 INFO - mozprocess == 0.22 11:09:48 INFO - mozprofile == 0.27 11:09:48 INFO - mozrunner == 6.11 11:09:48 INFO - mozscreenshot == 0.1 11:09:48 INFO - mozsystemmonitor == 0.0 11:09:48 INFO - moztest == 0.7 11:09:48 INFO - mozversion == 1.4 11:09:48 INFO - psutil == 3.1.1 11:09:48 INFO - requests == 1.2.3 11:09:48 INFO - wsgiref == 0.1.2 11:09:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:09: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')]} 11:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09: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')]} 11:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:09:48 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 0x105217490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051f4228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81ebe14f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10513b9f0>, '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 0x104e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512e8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/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.iD34s3jT4B/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 11:09:48 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 11:09:48 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 11:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/Render', 11:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:09:48 INFO - 'HOME': '/Users/cltbld', 11:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:09:48 INFO - 'LOGNAME': 'cltbld', 11:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:09:48 INFO - 'MOZ_NO_REMOTE': '1', 11:09:48 INFO - 'NO_EM_RESTART': '1', 11:09:48 INFO - 'PAGER': '/bin/cat', 11:09:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:09:48 INFO - 'PWD': '/builds/slave/test', 11:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:09:48 INFO - 'SHELL': '/bin/bash', 11:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iD34s3jT4B/Listeners', 11:09:48 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 11:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:09:48 INFO - 'USER': 'cltbld', 11:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:09:48 INFO - 'XPC_FLAGS': '0x0', 11:09:48 INFO - 'XPC_SERVICE_NAME': '0', 11:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 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)) 11:09:49 INFO - Cleaning up... 11:09:49 INFO - Return code: 0 11:09:49 INFO - Running post-action listener: _resource_record_post_action 11:09:49 INFO - Running post-action listener: _start_resource_monitoring 11:09:49 INFO - Starting resource monitoring. 11:09:49 INFO - ##### 11:09:49 INFO - ##### Running install step. 11:09:49 INFO - ##### 11:09:49 INFO - Running pre-action listener: _resource_record_pre_action 11:09:49 INFO - Running main action method: install 11:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:09:49 INFO - Reading from file tmpfile_stdout 11:09:49 INFO - Detecting whether we're running mozinstall >=1.0... 11:09:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:09:49 INFO - Reading from file tmpfile_stdout 11:09:49 INFO - Output received: 11:09:49 INFO - Usage: mozinstall [options] installer 11:09:49 INFO - Options: 11:09:49 INFO - -h, --help show this help message and exit 11:09:49 INFO - -d DEST, --destination=DEST 11:09:49 INFO - Directory to install application into. [default: 11:09:49 INFO - "/builds/slave/test"] 11:09:49 INFO - --app=APP Application being installed. [default: firefox] 11:09:49 INFO - mkdir: /builds/slave/test/build/application 11:09:49 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'] 11:09:49 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 11:10:31 INFO - Reading from file tmpfile_stdout 11:10:31 INFO - Output received: 11:10:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:10:31 INFO - Running post-action listener: _resource_record_post_action 11:10:31 INFO - ##### 11:10:31 INFO - ##### Running run-tests step. 11:10:31 INFO - ##### 11:10:31 INFO - Running pre-action listener: _resource_record_pre_action 11:10:31 INFO - Running main action method: run_tests 11:10:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:10:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:10:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:10:31 INFO - 2015-11-17 11:10:31.901 screenresolution[1962:17222] starting screenresolution argv=screenresolution get 11:10:31 INFO - 2015-11-17 11:10:31.905 screenresolution[1962:17222] Display 0: 1600x1200x32@60 11:10:31 INFO - 2015-11-17 11:10:31.912 screenresolution[1963:17224] starting screenresolution argv=screenresolution list 11:10:31 INFO - Available Modes on Display 0 11:10:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:10:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:10:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:10:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:10:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:10:32 INFO - Intel HD Graphics 3000: 11:10:32 INFO - Chipset Model: Intel HD Graphics 3000 11:10:32 INFO - Type: GPU 11:10:32 INFO - Bus: Built-In 11:10:32 INFO - VRAM (Total): 512 MB 11:10:32 INFO - VRAM (Dynamic, Max): 10 11:10:32 INFO - Vendor: Intel (0x8086) 11:10:32 INFO - Device ID: 0x0116 11:10:32 INFO - Revision ID: 0x0009 11:10:32 INFO - Displays: 11:10:32 INFO - Display: 11:10:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:10:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:10:32 INFO - Display Serial Number: 1600x1200 60 11:10:32 INFO - Main Display: Yes 11:10:32 INFO - Mirror: Off 11:10:32 INFO - Online: Yes 11:10:32 INFO - Rotation: Supported 11:10:32 INFO - Return code: 0 11:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:10:32 INFO - Python 2.7.3 11:10:32 INFO - Return code: 0 11:10:32 INFO - grabbing minidump binary from tooltool 11:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:10:32 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 0x10513b9f0>, '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 0x104e9adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10512e8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:10:32 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 11:10:32 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 11:10:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:10:32 INFO - Return code: 0 11:10:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:10:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:10:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:10:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:10:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0090', '--webServer', 'localhost'] in /builds/slave/test/build 11:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0090 --webServer localhost 11:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Y9ahx9bEcP/Render', 11:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:10:32 INFO - 'HOME': '/Users/cltbld', 11:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:10:32 INFO - 'LOGNAME': 'cltbld', 11:10:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:10:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:10:32 INFO - 'MOZ_NO_REMOTE': '1', 11:10:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:10:32 INFO - 'NO_EM_RESTART': '1', 11:10:32 INFO - 'PAGER': '/bin/cat', 11:10:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:10:32 INFO - 'PWD': '/builds/slave/test', 11:10:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:10:32 INFO - 'SHELL': '/bin/bash', 11:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iD34s3jT4B/Listeners', 11:10:32 INFO - 'TMPDIR': '/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/', 11:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:10:32 INFO - 'USER': 'cltbld', 11:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:10:32 INFO - 'XPC_FLAGS': '0x0', 11:10:32 INFO - 'XPC_SERVICE_NAME': '0', 11:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 11:10:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0090', '--webServer', 'localhost'] with output_timeout 3600 11:10:32 INFO - mozversion INFO | application_buildid: 20151117093002 11:10:32 INFO - mozversion INFO | application_changeset: 06188c6531b5b06fc9bd2cdcd25eaf5c1b778882 11:10:32 INFO - mozversion INFO | application_display_name: Nightly 11:10:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:10:32 INFO - mozversion INFO | application_name: Firefox 11:10:32 INFO - mozversion INFO | application_remotingname: firefox 11:10:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:10:32 INFO - mozversion INFO | application_vendor: Mozilla 11:10:32 INFO - mozversion INFO | application_version: 45.0a1 11:10:32 INFO - mozversion INFO | platform_buildid: 20151117093002 11:10:32 INFO - mozversion INFO | platform_changeset: 06188c6531b5b06fc9bd2cdcd25eaf5c1b778882 11:10:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:10:32 INFO - mozversion INFO | platform_version: 45.0a1 11:10:32 INFO - 2015-11-17 11:10:32,589 DEBUG : using testdate: 1447787432 11:10:32 INFO - 2015-11-17 11:10:32,589 DEBUG : actual date: 1447787432 11:10:32 INFO - 2015-11-17 11:10:32,672 INFO : starting webserver on 'localhost:51223' 11:10:32 INFO - 2015-11-17 11:10:32,673 INFO : Starting test suite t-yosemite-r5-0090.e 11:10:32 INFO - 2015-11-17 11:10:32,673 INFO : Starting test dromaeo_css 11:10:32 INFO - 2015-11-17 11:10:32,673 DEBUG : operating with platform_type : mac_ 11:10:32 INFO - 2015-11-17 11:10:32,674 INFO : Initialising browser for dromaeo_css test... 11:10:32 INFO - 2015-11-17 11:10:32,697 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmp9hiRyK/profile http://localhost:51223/getInfo.html 11:10:36 INFO - 2015-11-17 11:10:36,518 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:10:36 INFO - 2015-11-17 11:10:36,518 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:10:36 INFO - 2015-11-17 11:10:36,519 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:10:36 INFO - 2015-11-17 11:10:36,519 DEBUG : BROWSER_OUTPUT: __metrics 11:10:37 INFO - 2015-11-17 11:10:37,427 INFO : Browser initialized. 11:10:37 INFO - 2015-11-17 11:10:37,428 INFO : Running cycle 1/1 for dromaeo_css test... 11:10:37 INFO - 2015-11-17 11:10:37,428 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmp9hiRyK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:10:49 INFO - 2015-11-17 11:10:49,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 241635328 11:10:49 INFO - 2015-11-17 11:10:49,716 DEBUG : BROWSER_OUTPUT: 11:11:39 INFO - 2015-11-17 11:11:39,577 DEBUG : BROWSER_OUTPUT: 1447787499576 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] 11:13:50 INFO - 2015-11-17 11:13:50,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51223/tests/dromaeo/cssquery-ext.html) 11:13:51 INFO - 2015-11-17 11:13:51,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 265187328 11:13:51 INFO - 2015-11-17 11:13:51,284 DEBUG : BROWSER_OUTPUT: 11:16:53 INFO - 2015-11-17 11:16:53,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/dromaeo/cssquery-ext.html (next: http://localhost:51223/tests/dromaeo/cssquery-jquery.html) 11:16:53 INFO - 2015-11-17 11:16:53,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 271536128 11:16:53 INFO - 2015-11-17 11:16:53,937 DEBUG : BROWSER_OUTPUT: 11:19:55 INFO - 2015-11-17 11:19:55,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51223/tests/dromaeo/cssquery-mootools.html) 11:19:56 INFO - 2015-11-17 11:19:56,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 273686528 11:19:56 INFO - 2015-11-17 11:19:56,429 DEBUG : BROWSER_OUTPUT: 11:22:58 INFO - 2015-11-17 11:22:58,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51223/tests/dromaeo/cssquery-prototype.html) 11:22:58 INFO - 2015-11-17 11:22:58,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 279007232 11:22:58 INFO - 2015-11-17 11:22:58,762 DEBUG : BROWSER_OUTPUT: 11:26:01 INFO - 2015-11-17 11:26:01,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51223/tests/dromaeo/cssquery-yui.html) 11:26:02 INFO - 2015-11-17 11:26:02,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 283975680 11:26:02 INFO - 2015-11-17 11:26:02,068 DEBUG : BROWSER_OUTPUT: 11:29:04 INFO - 2015-11-17 11:29:04,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/dromaeo/cssquery-yui.html (next: http://localhost:51223/tests/dromaeo/cssquery-dojo.html) 11:29:04 INFO - 2015-11-17 11:29:04,655 DEBUG : BROWSER_OUTPUT: RSS: Main: 289619968 11:29:04 INFO - 2015-11-17 11:29:04,655 DEBUG : BROWSER_OUTPUT: 11:29:04 INFO - 2015-11-17 11:29:04,655 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:29:04 INFO - 2015-11-17 11:29:04,656 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:29:04 INFO - 2015-11-17 11:29:04,656 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:29:04 INFO - 2015-11-17 11:29:04,656 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:29:04 INFO - 2015-11-17 11:29:04,657 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2522.1424715596695;2545.1473756291643;2603.336149281934;2626.0939975708384;2685.9731402685966;4307.353896915464;4324.524302326746;4357.716748411355;4360.694751367406;4374.431323927889;4314.223439780838;4397.076613911075;4404.405405270288;4471.843485478009;4537.160625284317;3989.4614227079337;3997.7401468904573;4086.83652653895;4089.9795501022454;4144.8963775905695;4064.5325787534516;4101.118259574191;4159.355299928516;4174.749515029108;4206.326987681971;3820.4842346283176;3853.6339047790693;3929.096307849211;3999.680025597945;4012.478377810895;4007.6192761687594;4014.6788256939376;4090.1001779608437;4114.506259248879;4125.50493940729;3969.7221194516396;3998;4045.797710114512;4063.3701776224734;4093.5292441369324;4140.523839758436;4169.541350451448;4334.263175260214;4407.669424793154;4416.050549131952;4554.931676024862;4659.347691323217;4669.7898594562985;4708.246680531099;4713.457952335491;4450.488193857683;4718.811247550094;4737.73942433166;4763.309320148559;4783.545563171493;4300.11847571244;4301.07526881722;4315.3742707307265;4323.027318853233;4398.186335527937;4777.402824646919;4845.830395936196;4865.781039853215;4874.610031197567;4907.754612269372;4402.471703395613;4532.410786597788;4622.098690755338;4646.140464014168;4685.390899183152;4473;4603.49361570227;4631.861044168681;4638.397008388888;4657.068586282757;4557.361969324297;4569.954300456953;4646.186917289461;4647.953520464752;4655.743934083658;4444.044530425974;4539.409876716072;4609.861704148814;4611.354410382549;4633.2818413146015;3547.485614585922;3572.160542272564;3606.1705807664384;3629.8185090745355;3636.090977255686;3268.9019329420157;3273.3780581689402;3282.901512954615;3305.752068594865;3330.9833450833075;4294.184105020036;4380.408644832971;4440.156370289635;4444.022315090675;4535.7732113394195;4659.534046595381;4733.597644200213;4780.235162374003;4782.665213435026;4827.565519103227;4436.955630443719;4491.438570178728;4492.056668099735;4492.101579684077;4498.482674492409;4069.1658210066867;4094.9181016379507;4137.97931010343;4140.4617399737845;4211.684123690736;4766.97510035344;4779.330893674958;4856.878578035577;4885.706857588556;4939.703617782944;4486.349479325545;4755.239161734106;4786.569208771228;4803.927941080957;4846.80612775485;4790.377250957354;4798.640101992434;4846.927296090491;4875.609951203966;4959.801607935642;4636.026434448803;4672.6495512837355;4679.649026323107;4691.202495575829;4844.588210002189;4595.954040459686;4733.810647574059;4768.3085952537385;4785.928211076767;4790.616750660009;4466.821327146878;4562.019165879352;4606.88482787933;4618.838340658195;4641.489436161952;4570.931436028529;4572.428446444194;4598.540145985375;4649.209634362234;4663.230566956414;4121.979390103031;4225.704200705921;4358.847440339573;4516.412866327357;4530.388397566287;4534.931976020428;4540.455145382575;4572.268437050056;4581.473130589891;4618.330342100309;4471.754053526957;4498.865034048984;4504.211762941407;4509.210888094504;4539.364488971481 11:29:04 INFO - 2015-11-17 11:29:04,662 DEBUG : BROWSER_OUTPUT: |1;ext.html;452.45479197566954;470.02938931107263;476.36643264458274;490.2254437987978;506.13450998792064;29792.702072979264;30944.535831962483;31079.37841243174;31084.689153108462;31411;34601.30797384051;35521.28957420857;35743.999999999935;36095.27809443816;36241.45637815435;7503.7748867534065;7649.04386951631;7657.923420765805;7733.41999350051;7734.110577283628;7684.769456916273;7724.304812566867;7734;7793.025871766029;7877.566733829637;7686.231376862325;7690.730824421146;7698.499597526171;7747.496412733154;7807.336376408012;7618.885716714254;7655.770326890174;7670.846583068335;7725.49784264021;7758.262965018314;7517;7661.272179142972;7701.537907725555;7704.3451306639;7754.18581048993;32097.197570060704;32736.508952365733;32825.50761738576;33107.6689233107;33221.50167747486;2282.155602427096;2414.8913298901593;2446.60854263317;2616.7252438493874;2843.260752204421;22227.44431389212;22338.329850104525;22606.095756169732;22876.313710588707;23232.53534929292;1930.4884205685505;1934.6517626827165;1941.417574727576;1965.980340196594;2011.2960463837685;221616;224688;225511;227834;229467;47533;49273.50726492761;50417.74791126021;51279.487205128215;51606.22590661143;46653.76673116613;46959.5304046962;47045;47102;48043.27935080977;13803.792943105862;14079.507217247346;14130.71738565223;14144.00991930555;14181;10405.375677459377;10527.631532896312;10584.841227381596;10703.1437485001;10704.250702450909;16558.503244902673;16839.74740378895;16983.150842457828;17041.659166816844;17049;7285.599292038883;7448.106227252764;7450.0687414073245;7562.848743025109;7581.810454738676;707.2856415020866;741.1513816679872;747.7980945144889;764.7820371194183;795.8647030004913;23355;23465.88267058654;23739.40651483727;23889.7611023891;24080.51838963211;877.9683871451147;931.8089791592707;943.8725772020827;988.960441582343;1027.1166796554958;11781.930841495207;11787.233829801207;11859.407029648655;12045.156839021185;12051.819222711667;330433;335243;337251;342452;342503;44263.55736442594;45245.32132018022;45252.09495810131;45442.77278613586;45879.54120458753;1173.8180582009802;1185.1230089733535;1186.8991135753386;1187.2283016039644;1199.346356235836;22016.559668806214;22622.095116195826;22740.4314892129;22820.885895570416;22950.426239343484;37257.254854903294;37796.24407511889;37900.62099378971;38307.2338553233;38328.23343533058;250460;253460;253469;258145;259469;26224.21327360182;35632.82183589169;37729.62270377261;37888.242235155696;37917;34600.48099278563;35066.12334691551;35330.11674708153;35500.467492988144;35687.82156089203;28801.423971520035;29338.706612933598;29879;30149.75338232662;30314.696853031186;29157.271068223465;29670;29752.702472974994;29924;30219.546706799854;29092.418151637274;29540.556891647073;29811.403771924008;30237.244068898453;30254.697453025186;25758.484830303663;26468.205953821416;26709.19872403831;26852.32869178208;27286.317842054108;20184.49538761543;20462;20465.05147611316;20472.79527204709;20846 11:29:04 INFO - 2015-11-17 11:29:04,662 DEBUG : BROWSER_OUTPUT: |2;jquery.html;280.15253857082325;282.0241962808682;284.1206465987767;286.95121829289025;290.08767426443836;12803.359832008386;14307.499237526688;14844.109353438802;14921.179335136563;15231.923840380783;14612.4885629003;14725.852741472581;14735.26323683817;14854.925725371386;15130.319135638894;4387.890302742425;4477.776111194444;4617.699849509788;4658.697184682985;4660.603848672867;4562.315652652095;4579.564941330568;4582.6104781093645;4583.885402864938;4616.8153273869;3223.774335796495;4078.877633670995;4584.656150788687;4621.145088158684;5119.974400127994;4947.406311242674;4997.925031124536;5018.2974383586325;5022.698638081709;5057.291979122944;4070.816813243411;4079.836806527765;4081.1225586499045;4239.7668128252935;4358.803853826554;16756.58108547296;17592.824071759245;17666.470005899715;18256.995865227407;18436.631267374712;1385.0512399006714;1505.9698806023819;1508.2684897824547;1554.6968341173476;1763.3475614022766;7746.264104910025;7783.805404864867;7964.203579642048;8016.238457346542;8043.356531477468;1259.716563773153;1281.398252184769;1283.5250957145822;1297.5393735223954;1305.3342795174528;47986.520134798906;49168;49334.25998610024;50214;50283;5302.840914772563;5338.973305133527;5398.298221231294;5400.351957765093;5455.018096742624;6029.216201893813;6102.267727872683;6117.541184411187;6136.8953588354525;6143.600665956698;4516.23224051912;4535.138323718483;4566.178087944136;4567.132244873464;4572.337011133433;4914.287428322873;4949.133901567211;4966.975165124223;4977.352944117241;4990.575801056951;2395.4610212702;2412.4210189554733;2421.503591763684;2447.2902858170933;2452.3256104571387;848.4612271207704;851.7529916324321;867.4665080975154;873.4366333714719;918.4213945214606;314.07035175879196;315.8136699347396;320.3177232494771;347.725585728308;390.79678567144924;8367.874481882776;8816.691415800417;9527.285453591008;9810.16613587853;9858.704238872846;374.6964958383718;381.1253173965755;383.9174577465858;389.05653789560205;389.7057721420309;5113.974430127825;5352.705601191894;5364.329458817648;5426.67439953604;5443.074677304868;465946;484170;485311;488363;504987.3279779249;55231.72384138054;62567;63160.36839631545;64225.67887160534;65992;404.561051259381;413.9834406623701;417.6533477213905;419.7607363802603;424.07551537647606;8733.432326898732;8834.867476987978;8895.332850036144;9000.144986226298;9019.503927284062;29874.103776886728;30055.519806054766;30302.848485758313;30392;31071.68928310688;42018;42180.15639687128;42363.1527369457;43122.568774311854;43125.56874431216;5076.898462030813;5142.382914050338;5155.9742201290255;5190.221466779863;5233.345831771028;9099.272058235192;9810.215182785218;9826.459544725109;9841.507924603884;9995.350302230332;7090.468214883801;8132.30875375576;8510.82978340442;8572.314214862921;8583.18459746323;7981.1619779924595;8201.26188643025;8252.133525979925;8391.66433342684;8456.069832318317;8348.624311905858;8481.067082620782;8535.871961920451;8676.522791246542;8779.034306226438;5048.59611231108;5164.431912489548;5165.638405311592;5191.662541934762;5235.58639167415;8485.109063548485;8494.193051660082;8642.78393040179;8644.092370301028;8668.176523230282 11:29:04 INFO - 2015-11-17 11:29:04,663 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1146.0831334932057;1190.4880901212475;1201.2612243470264;1222.541546919905;1244.3964677131592;5725.169850371693;5916.319623243328;6318.494520438366;6677.198736151657;6718.89921651175;6217.5025997920175;6250.843728906768;6332.968335158329;6351.650659213741;6416.230052393707;1860.8139186081385;1895.2419032387018;1903.0674969265099;1915.6264528416964;1925.951851203717;1809.1677828199045;1903.3528600275904;1936.9031548422593;1948.298612499499;1958.8432925365937;1908.5610309628794;1915.9904200478977;1926.210253795944;1940.41787463761;1944.1542928825936;1822.4532640207951;1852.0832188066927;1861.3485280151974;1877.962440751191;1894.2991093295432;1856.4337876947525;1857.117869012222;1867.2251015828415;1887.6790945539153;1919.1267973072218;6389.872202555969;6411.551191416603;6424;6472.546921715481;6482.513811464159;4143.8964025899295;4177.164567086595;4220.198162349144;4227.471566054243;4270.444842170529;2423.551642946061;2433.8661373624445;2451.9509609807706;2467.3584867934464;2511.4349271413967;723.2333726250191;746.5856449670431;751.3087959077661;753.5968256982543;757.3978686943893;8721.30229581632;8734.213920747163;8789.165029322205;8835.558222088934;8867.246284065863;3740.706899736842;3761.7931013794505;3803.7717736935874;3810.1046254130256;3839.251345987506;7433.219511951167;7499.550026998398;7509;7538.396928245727;7582;4159.168166366739;4159.313713237342;4216.219999300078;4218.6414154797185;4220.261454245495;3296.241864371208;3411.249525104473;3784.6783023443318;3816.9427458588143;3835.290471262825;2993.236724635248;3076.86154123065;3089.4902341113466;3091.8144911305394;3106.813591184536;976.9462679552693;992.8064027514565;996.1383403356045;996.6910257820099;1004.9799004019878;798.4331124901269;800.3357213512887;808.6765293882377;809.2433574607761;951.2247518272724;6045.183900173421;6046.123312119806;6049.425304596057;6058.0610005449225;6079.939200608026;926.6571368593663;957.6552441121191;961.6586111930304;966.4346357380871;971.121135372489;4681.414823147106;4822.517748225149;4851.417829860439;4863.7324947128245;4876.561109500091;7403.074615673041;7478.326950574366;7510.436717246228;7548.735794247175;7619.504732192389;7426.888596671054;7476.177620461854;7484.064491938508;7489.325960663567;7535.208803075599;6054.182685337511;6103.542234332532;6105.419985101408;6124.35694252106;6180.412860778219;5950.761969521171;5989.580729349078;6025.427584379477;6029.547783916311;6078.756849726138;6572.8356791080605;6731.1922569292;6731.427828634621;6754.831129221809;6817.113775209191;6835.043093966948;6977.302269772982;6987.266337034742;6990.685419156252;7028.121484814398;5310.8141215057285;5469.015577196143;5731.942680573307;5826.960563802635;5848.8887111448685;5948.821535353946;6344.270408903035;6352.523560732871;6375.808725738235;6404.519661025349;5705;5723.370429252862;5841.094630332305;5950.761969521171;6006.759729610942;5781.710914454176;5782.074868021096;5890.2342695449315;5902.2622172228475;5914.378990205966;5895.322037965518;5940.405959404025;5948.97025514887;5981.222441082631;6021.367756385516;5370.140777475585;5406.702631355313;5412.8646783829145;5461.371942226695;5467.72661366938;5407.78368865241;5424.457554244544;5454.427285135003;5483.122700367922;5530.806421775219 11:29:04 INFO - 2015-11-17 11:29:04,667 DEBUG : BROWSER_OUTPUT: |4;prototype.html;252.3514567561367;257.9793616510678;266.8572313812111;268.07647653832555;270.0655731170151;5209.947900520993;5245.527902488775;5324.627276090675;5332.986732520823;5356.866078348044;5205.115130427826;5334.67991920485;5385.7576409061585;5422.511973922346;5494.203340515623;4061.675065994728;4063.2279866825356;4083.6528895043957;4107.79461026949;4111.013356794363;4078.8572399966006;4087.3255912774357;4104.199681062194;4113.095119073799;4118.320477121287;3848.942265866014;4038.131801662642;4052.635262826345;4110.362893751473;4112.198121366319;3982.8406863725418;4010.83956641734;4014.0366312085034;4035.535913369971;4063.1061166543313;3387.5257463955068;3393.1347506385714;3401.268727223634;3427.108951672583;3452.3095380923664;5045.646804723634;5170.45710200431;5183.585313174937;5241.633085684004;5269.815556455544;4445.688801783876;4481.484629267611;4487.573680500347;4499.61753250974;4524.909501809978;5590.161475778625;5609.831705048855;5648.124540696199;5658.575606829463;5709.657420554739;3662.0661731258624;3668.486411902309;3668.6976123476047;3684.7236457265813;3695.224002959382;5728.656280623176;5743.339515955635;5849.356570777211;5869.882602347971;5879;3740.7942563158745;3747.38168202249;3752.6622603965775;3774.5281839770028;3779.981100094482;3820.0640842993644;3852.6725228355904;3852.691784657277;3854.1520865409566;3876.341022026262;4477.932831007537;4489.304157855538;4494.5730155635165;4535.546445355504;4581.610563102107;5276.155815069647;5432.565394768409;5453.563714902798;5603.719814009283;5665.801696940587;1321.8281623388898;1340.128916204475;1348.0563605476207;1360.081944687332;1367.699106196635;846.7502086884384;857.0443954990141;864.9308055355557;866.5017614871474;872.2585802068318;5271.65734227274;5399.217113518518;5448.782048718086;5452.427495113036;5458.808941687022;5838.32859221195;5845.240118784531;5850.765969361178;5891.1457838614015;5956.7319470623925;5388.245645609618;5403.027455058127;5404.29744133268;5408.4050754416985;5486.478784515464;3083.8766449341774;3115.501519756828;3156.636986746508;3166.920826979344;3179.030395729325;5954.10688396744;6073;6077.665728384893;6092.634441933409;6115.4801841843055;6051.697415129226;6065.454109130112;6075.817725468243;6107.0228763397645;6126.724297406538;5881;6039.54703397247;6059.333473317932;6101.589872000535;6132.018876979841;5908.202392676933;5922.911156332572;5941.643501389757;5955.153902290131;5997.190379298913;5798.217240672455;5799.710014499174;5819.4180581943165;5857.765689372548;5870.26621672291;6035;6045.848853778515;6046.425589568984;6102.603330783662;6130.785422510191;3652.4886515887265;3814.847406103836;3821.7706937583835;3823.9044023899623;3865.053061999828;5618.213450116905;5816.331121920864;5833.708314584169;5874.823755287348;5883.999720047516;5629.437056294338;5657.094864821609;5669.262995810518;5677.574181936288;5702;5622.409646987171;5723.656580605177;5732.742026608896;5763.077907534775;5824.825255242349;5392.892142157213;5570.387257401601;5587.217789509391;5637.379888212211;5652.88694226105;5704.401037890962;5705.087186050212;5731.111677689964;5773.624714393551;5828.446297601721;5615.522680572197;5623.578231632726;5632.887342253214;5671.574631902541;5718.885622287614 11:29:04 INFO - 2015-11-17 11:29:04,668 DEBUG : BROWSER_OUTPUT: |5;yui.html;511.7492428709931;552.9032419326619;628.2806186915981;634.8670995005381;650.2554575011609;11625.302481851084;11983.640490785268;12028.037756979442;12033.51865925363;12164.695882602939;10084.848727269096;10571.048605625492;10805.189610779204;11083.445827708603;11178.217524773248;744.970201191953;761.4859969520579;763.0995425398028;768.4812751392816;768.7693691892438;740.4076738609118;747.4805010517692;747.4954405776107;748.1060133140899;756.9091708994928;777.3004296133469;783.5259667900923;783.9294463498284;784.9529028258294;785.4148659248867;755.4296506137886;774.1832366852968;776.3711393771035;776.5263189454429;776.8679324514818;571.043502133924;574.704027425876;578.6788332475475;578.713536799287;578.9752138714493;10511.264211505199;10537.473126343728;10677.679669609925;10721.249512534127;10793.946030269877;8001.1198768135455;8061.234182752688;8251.669933202666;8612.5693715314;8863.423877448009;7171.89242161368;7372.967784510173;7398.149212840538;7447.627618619047;7683.193264707237;2582.457683886386;2593.7924966002674;2657.627932089509;2661.5874539446418;2700.9189724308108;37794;37846.24307513862;40841.9999999997;43333.566664333266;43846;7305.561666300039;7344.926550734531;7359.926400735924;7499.354531191008;7589.165191828894;16105.838941610435;16170.191490425432;16200.918995405184;16316.021038737475;16498.67002659964;5712.485876271156;5755.251817263729;5811.56413268998;5848.824535263949;6107.877842443127;3118.7037231462973;3120.3135310231714;3161.65221825599;3220.6618305077627;3223.6615155408813;2430.4652976345174;2468.8148388870904;2472.2088931542094;2494.8627825469775;2499.800015998716;352.33760530203057;360.3351815899661;362.68084086004677;364.7592588891319;371.5411466838452;453.7073587536021;455.4739276136068;468.1736734663322;480.82209582454715;528.9047971365192;5903.291605007426;6328.9257181373;6585.835354116185;6588.769393071219;6597.175353080865;455.9890881213897;466.5660935330176;473.56432082484196;487.33722137892437;493.20347638563464;2977.940441191164;2978.2107741448535;3015.1256135720832;3016.2308611304416;3036.6963303669454;51779;52214.47785522096;52391.47608523866;52423.73788131035;52973;46046.76976615095;46065.078698425845;46312.53687463082;46313.76843115763;46456;37404.25191496155;37905.05237369088;38872.22255554873;38937.41593876094;40100.799496002335;6879.690413931285;6923.342282483156;6955.826104347432;6962.373386395248;7168.784936451915;29268.268293291985;30034.098977030724;30052;30212;30446.84776576103;38303.808480957414;38990.02524936899;40094;40466.39300410437;40505.1898962025;5930.9110363343725;6137.570370074231;6138.324784273637;6277.780277690442;6279.246490421178;8313.750587482386;9002.18485136524;9032.819343613222;9316.767080823034;9685.515724213901;8663.220310172115;8873.023967363455;8914.86627700572;8917.821643566962;8921.330900182642;9013.188813006598;9067.36528443029;9118.747194653739;9146.771330716785;9157.633694652406;8814.5592720365;8900.198982091642;9045.231155351868;9149.496777677292;9287.349885507949;7577.355924746238;7742.690292388242;7810.179931107152;7957.1644977276555;8279.793005174919;7690.083839260009;7837.373010159287;7843.56860372685;7987.880181797162;8003.159668234985 11:29:04 INFO - 2015-11-17 11:29:04,668 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:29:04 INFO - 2015-11-17 11:29:04,668 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:29:04 INFO - 2015-11-17 11:29:04,669 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,298 11:29:04 INFO - 2015-11-17 11:29:04,669 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:29:04 INFO - 2015-11-17 11:29:04,669 DEBUG : BROWSER_OUTPUT: __startTimestamp1447788544654__endTimestamp 11:29:04 INFO - 2015-11-17 11:29:04,669 DEBUG : BROWSER_OUTPUT: 11:29:04 INFO - 2015-11-17 11:29:04,669 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:29:04 INFO - 2015-11-17 11:29:04,669 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:29:04 INFO - 2015-11-17 11:29:04,669 DEBUG : BROWSER_OUTPUT: 11:29:04 INFO - 2015-11-17 11:29:04,669 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4362.30 Median:4498.48 stddev:477.04 (10.6%) stddev-sans-first:456.14 11:29:04 INFO - 2015-11-17 11:29:04,671 DEBUG : BROWSER_OUTPUT: Values: 2522.1 2545.1 2603.3 2626.1 2686.0 4307.4 4324.5 4357.7 4360.7 4374.4 4314.2 4397.1 4404.4 4471.8 4537.2 3989.5 3997.7 4086.8 4090.0 4144.9 4064.5 4101.1 4159.4 4174.7 4206.3 3820.5 3853.6 3929.1 3999.7 4012.5 4007.6 4014.7 4090.1 4114.5 4125.5 3969.7 3998.0 4045.8 4063.4 4093.5 4140.5 4169.5 4334.3 4407.7 4416.1 4554.9 4659.3 4669.8 4708.2 4713.5 4450.5 4718.8 4737.7 4763.3 4783.5 4300.1 4301.1 4315.4 4323.0 4398.2 4777.4 4845.8 4865.8 4874.6 4907.8 4402.5 4532.4 4622.1 4646.1 4685.4 4473.0 4603.5 4631.9 4638.4 4657.1 4557.4 4570.0 4646.2 4648.0 4655.7 4444.0 4539.4 4609.9 4611.4 4633.3 3547.5 3572.2 3606.2 3629.8 3636.1 3268.9 3273.4 3282.9 3305.8 3331.0 4294.2 4380.4 4440.2 4444.0 4535.8 4659.5 4733.6 4780.2 4782.7 4827.6 4437.0 4491.4 4492.1 4492.1 4498.5 4069.2 4094.9 4138.0 4140.5 4211.7 4767.0 4779.3 4856.9 4885.7 4939.7 4486.3 4755.2 4786.6 4803.9 4846.8 4790.4 4798.6 4846.9 4875.6 4959.8 4636.0 4672.6 4679.6 4691.2 4844.6 4596.0 4733.8 4768.3 4785.9 4790.6 4466.8 4562.0 4606.9 4618.8 4641.5 4570.9 4572.4 4598.5 4649.2 4663.2 4122.0 4225.7 4358.8 4516.4 4530.4 4534.9 4540.5 4572.3 4581.5 4618.3 4471.8 4498.9 4504.2 4509.2 4539.4 11:29:04 INFO - 2015-11-17 11:29:04,671 DEBUG : BROWSER_OUTPUT: 11:29:04 INFO - 2015-11-17 11:29:04,671 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41136.67 Median:31247.84 stddev:72769.44 (232.9%) stddev-sans-first:72909.47 11:29:04 INFO - 2015-11-17 11:29:04,672 DEBUG : BROWSER_OUTPUT: Values: 452.5 470.0 476.4 490.2 506.1 29792.7 30944.5 31079.4 31084.7 31411.0 34601.3 35521.3 35744.0 36095.3 36241.5 7503.8 7649.0 7657.9 7733.4 7734.1 7684.8 7724.3 7734.0 7793.0 7877.6 7686.2 7690.7 7698.5 7747.5 7807.3 7618.9 7655.8 7670.8 7725.5 7758.3 7517.0 7661.3 7701.5 7704.3 7754.2 32097.2 32736.5 32825.5 33107.7 33221.5 2282.2 2414.9 2446.6 2616.7 2843.3 22227.4 22338.3 22606.1 22876.3 23232.5 1930.5 1934.7 1941.4 1966.0 2011.3 221616.0 224688.0 225511.0 227834.0 229467.0 47533.0 49273.5 50417.7 51279.5 51606.2 46653.8 46959.5 47045.0 47102.0 48043.3 13803.8 14079.5 14130.7 14144.0 14181.0 10405.4 10527.6 10584.8 10703.1 10704.3 16558.5 16839.7 16983.2 17041.7 17049.0 7285.6 7448.1 7450.1 7562.8 7581.8 707.3 741.2 747.8 764.8 795.9 23355.0 23465.9 23739.4 23889.8 24080.5 878.0 931.8 943.9 989.0 1027.1 11781.9 11787.2 11859.4 12045.2 12051.8 330433.0 335243.0 337251.0 342452.0 342503.0 44263.6 45245.3 45252.1 45442.8 45879.5 1173.8 1185.1 1186.9 1187.2 1199.3 22016.6 22622.1 22740.4 22820.9 22950.4 37257.3 37796.2 37900.6 38307.2 38328.2 250460.0 253460.0 253469.0 258145.0 259469.0 26224.2 35632.8 37729.6 37888.2 37917.0 34600.5 35066.1 35330.1 35500.5 35687.8 28801.4 29338.7 29879.0 30149.8 30314.7 29157.3 29670.0 29752.7 29924.0 30219.5 29092.4 29540.6 29811.4 30237.2 30254.7 25758.5 26468.2 26709.2 26852.3 27286.3 20184.5 20462.0 20465.1 20472.8 20846.0 11:29:04 INFO - 2015-11-17 11:29:04,673 DEBUG : BROWSER_OUTPUT: 11:29:04 INFO - 2015-11-17 11:29:04,673 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23708.33 Median:49251.13 stddev:79557.79 (161.5%) stddev-sans-first:79761.52 11:29:04 INFO - 2015-11-17 11:29:04,674 DEBUG : BROWSER_OUTPUT: Values: 280.2 282.0 284.1 287.0 290.1 12803.4 14307.5 14844.1 14921.2 15231.9 14612.5 14725.9 14735.3 14854.9 15130.3 4387.9 4477.8 4617.7 4658.7 4660.6 4562.3 4579.6 4582.6 4583.9 4616.8 3223.8 4078.9 4584.7 4621.1 5120.0 4947.4 4997.9 5018.3 5022.7 5057.3 4070.8 4079.8 4081.1 4239.8 4358.8 16756.6 17592.8 17666.5 18257.0 18436.6 1385.1 1506.0 1508.3 1554.7 1763.3 7746.3 7783.8 7964.2 8016.2 8043.4 1259.7 1281.4 1283.5 1297.5 1305.3 47986.5 49168.0 49334.3 50214.0 50283.0 5302.8 5339.0 5398.3 5400.4 5455.0 6029.2 6102.3 6117.5 6136.9 6143.6 4516.2 4535.1 4566.2 4567.1 4572.3 4914.3 4949.1 4967.0 4977.4 4990.6 2395.5 2412.4 2421.5 2447.3 2452.3 848.5 851.8 867.5 873.4 918.4 314.1 315.8 320.3 347.7 390.8 8367.9 8816.7 9527.3 9810.2 9858.7 374.7 381.1 383.9 389.1 389.7 5114.0 5352.7 5364.3 5426.7 5443.1 465946.0 484170.0 485311.0 488363.0 504987.3 55231.7 62567.0 63160.4 64225.7 65992.0 404.6 414.0 417.7 419.8 424.1 8733.4 8834.9 8895.3 9000.1 9019.5 29874.1 30055.5 30302.8 30392.0 31071.7 42018.0 42180.2 42363.2 43122.6 43125.6 5076.9 5142.4 5156.0 5190.2 5233.3 9099.3 9810.2 9826.5 9841.5 9995.4 7090.5 8132.3 8510.8 8572.3 8583.2 7981.2 8201.3 8252.1 8391.7 8456.1 8348.6 8481.1 8535.9 8676.5 8779.0 5048.6 5164.4 5165.6 5191.7 5235.6 8485.1 8494.2 8642.8 8644.1 8668.2 11:29:04 INFO - 2015-11-17 11:29:04,674 DEBUG : BROWSER_OUTPUT: 11:29:04 INFO - 2015-11-17 11:29:04,675 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4528.61 Median:5915.35 stddev:2311.22 (39.1%) stddev-sans-first:2303.72 11:29:04 INFO - 2015-11-17 11:29:04,675 DEBUG : BROWSER_OUTPUT: Values: 1146.1 1190.5 1201.3 1222.5 1244.4 5725.2 5916.3 6318.5 6677.2 6718.9 6217.5 6250.8 6333.0 6351.7 6416.2 1860.8 1895.2 1903.1 1915.6 1926.0 1809.2 1903.4 1936.9 1948.3 1958.8 1908.6 1916.0 1926.2 1940.4 1944.2 1822.5 1852.1 1861.3 1878.0 1894.3 1856.4 1857.1 1867.2 1887.7 1919.1 6389.9 6411.6 6424.0 6472.5 6482.5 4143.9 4177.2 4220.2 4227.5 4270.4 2423.6 2433.9 2452.0 2467.4 2511.4 723.2 746.6 751.3 753.6 757.4 8721.3 8734.2 8789.2 8835.6 8867.2 3740.7 3761.8 3803.8 3810.1 3839.3 7433.2 7499.6 7509.0 7538.4 7582.0 4159.2 4159.3 4216.2 4218.6 4220.3 3296.2 3411.2 3784.7 3816.9 3835.3 2993.2 3076.9 3089.5 3091.8 3106.8 976.9 992.8 996.1 996.7 1005.0 798.4 800.3 808.7 809.2 951.2 6045.2 6046.1 6049.4 6058.1 6079.9 926.7 957.7 961.7 966.4 971.1 4681.4 4822.5 4851.4 4863.7 4876.6 7403.1 7478.3 7510.4 7548.7 7619.5 7426.9 7476.2 7484.1 7489.3 7535.2 6054.2 6103.5 6105.4 6124.4 6180.4 5950.8 5989.6 6025.4 6029.5 6078.8 6572.8 6731.2 6731.4 6754.8 6817.1 6835.0 6977.3 6987.3 6990.7 7028.1 5310.8 5469.0 5731.9 5827.0 5848.9 5948.8 6344.3 6352.5 6375.8 6404.5 5705.0 5723.4 5841.1 5950.8 6006.8 5781.7 5782.1 5890.2 5902.3 5914.4 5895.3 5940.4 5949.0 5981.2 6021.4 5370.1 5406.7 5412.9 5461.4 5467.7 5407.8 5424.5 5454.4 5483.1 5530.8 11:29:04 INFO - 2015-11-17 11:29:04,675 DEBUG : BROWSER_OUTPUT: 11:29:04 INFO - 2015-11-17 11:29:04,675 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4695.85 Median:5415.46 stddev:1471.42 (27.2%) stddev-sans-first:1437.25 11:29:04 INFO - 2015-11-17 11:29:04,676 DEBUG : BROWSER_OUTPUT: Values: 252.4 258.0 266.9 268.1 270.1 5209.9 5245.5 5324.6 5333.0 5356.9 5205.1 5334.7 5385.8 5422.5 5494.2 4061.7 4063.2 4083.7 4107.8 4111.0 4078.9 4087.3 4104.2 4113.1 4118.3 3848.9 4038.1 4052.6 4110.4 4112.2 3982.8 4010.8 4014.0 4035.5 4063.1 3387.5 3393.1 3401.3 3427.1 3452.3 5045.6 5170.5 5183.6 5241.6 5269.8 4445.7 4481.5 4487.6 4499.6 4524.9 5590.2 5609.8 5648.1 5658.6 5709.7 3662.1 3668.5 3668.7 3684.7 3695.2 5728.7 5743.3 5849.4 5869.9 5879.0 3740.8 3747.4 3752.7 3774.5 3780.0 3820.1 3852.7 3852.7 3854.2 3876.3 4477.9 4489.3 4494.6 4535.5 4581.6 5276.2 5432.6 5453.6 5603.7 5665.8 1321.8 1340.1 1348.1 1360.1 1367.7 846.8 857.0 864.9 866.5 872.3 5271.7 5399.2 5448.8 5452.4 5458.8 5838.3 5845.2 5850.8 5891.1 5956.7 5388.2 5403.0 5404.3 5408.4 5486.5 3083.9 3115.5 3156.6 3166.9 3179.0 5954.1 6073.0 6077.7 6092.6 6115.5 6051.7 6065.5 6075.8 6107.0 6126.7 5881.0 6039.5 6059.3 6101.6 6132.0 5908.2 5922.9 5941.6 5955.2 5997.2 5798.2 5799.7 5819.4 5857.8 5870.3 6035.0 6045.8 6046.4 6102.6 6130.8 3652.5 3814.8 3821.8 3823.9 3865.1 5618.2 5816.3 5833.7 5874.8 5884.0 5629.4 5657.1 5669.3 5677.6 5702.0 5622.4 5723.7 5732.7 5763.1 5824.8 5392.9 5570.4 5587.2 5637.4 5652.9 5704.4 5705.1 5731.1 5773.6 5828.4 5615.5 5623.6 5632.9 5671.6 5718.9 11:29:04 INFO - 2015-11-17 11:29:04,677 DEBUG : BROWSER_OUTPUT: 11:29:04 INFO - 2015-11-17 11:29:04,677 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11513.54 Median:3166.97 stddev:14187.43 (448.0%) stddev-sans-first:14203.17 11:29:04 INFO - 2015-11-17 11:29:04,678 DEBUG : BROWSER_OUTPUT: Values: 511.7 552.9 628.3 634.9 650.3 11625.3 11983.6 12028.0 12033.5 12164.7 10084.8 10571.0 10805.2 11083.4 11178.2 745.0 761.5 763.1 768.5 768.8 740.4 747.5 747.5 748.1 756.9 777.3 783.5 783.9 785.0 785.4 755.4 774.2 776.4 776.5 776.9 571.0 574.7 578.7 578.7 579.0 10511.3 10537.5 10677.7 10721.2 10793.9 8001.1 8061.2 8251.7 8612.6 8863.4 7171.9 7373.0 7398.1 7447.6 7683.2 2582.5 2593.8 2657.6 2661.6 2700.9 37794.0 37846.2 40842.0 43333.6 43846.0 7305.6 7344.9 7359.9 7499.4 7589.2 16105.8 16170.2 16200.9 16316.0 16498.7 5712.5 5755.3 5811.6 5848.8 6107.9 3118.7 3120.3 3161.7 3220.7 3223.7 2430.5 2468.8 2472.2 2494.9 2499.8 352.3 360.3 362.7 364.8 371.5 453.7 455.5 468.2 480.8 528.9 5903.3 6328.9 6585.8 6588.8 6597.2 456.0 466.6 473.6 487.3 493.2 2977.9 2978.2 3015.1 3016.2 3036.7 51779.0 52214.5 52391.5 52423.7 52973.0 46046.8 46065.1 46312.5 46313.8 46456.0 37404.3 37905.1 38872.2 38937.4 40100.8 6879.7 6923.3 6955.8 6962.4 7168.8 29268.3 30034.1 30052.0 30212.0 30446.8 38303.8 38990.0 40094.0 40466.4 40505.2 5930.9 6137.6 6138.3 6277.8 6279.2 8313.8 9002.2 9032.8 9316.8 9685.5 8663.2 8873.0 8914.9 8917.8 8921.3 9013.2 9067.4 9118.7 9146.8 9157.6 8814.6 8900.2 9045.2 9149.5 9287.3 7577.4 7742.7 7810.2 7957.2 8279.8 7690.1 7837.4 7843.6 7987.9 8003.2 11:29:04 INFO - 2015-11-17 11:29:04,678 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:29:04 INFO - 2015-11-17 11:29:04,678 DEBUG : BROWSER_OUTPUT: 11:29:05 INFO - 2015-11-17 11:29:05,388 INFO : Browser exited with error code: 0 11:29:05 INFO - 2015-11-17 11:29:05,421 INFO : Completed test dromaeo_css (00:18:32) 11:29:05 INFO - 2015-11-17 11:29:05,421 INFO : Starting test kraken 11:29:05 INFO - 2015-11-17 11:29:05,421 DEBUG : operating with platform_type : mac_ 11:29:05 INFO - 2015-11-17 11:29:05,421 INFO : Initialising browser for kraken test... 11:29:05 INFO - 2015-11-17 11:29:05,436 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpve_OEI/profile http://localhost:51223/getInfo.html 11:29:08 INFO - 2015-11-17 11:29:08,807 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:29:08 INFO - 2015-11-17 11:29:08,808 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:29:08 INFO - 2015-11-17 11:29:08,808 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:29:08 INFO - 2015-11-17 11:29:08,808 DEBUG : BROWSER_OUTPUT: __metrics 11:29:09 INFO - 2015-11-17 11:29:09,535 INFO : Browser initialized. 11:29:09 INFO - 2015-11-17 11:29:09,536 INFO : Running cycle 1/1 for kraken test... 11:29:09 INFO - 2015-11-17 11:29:09,536 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpve_OEI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:29:21 INFO - 2015-11-17 11:29:21,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 241799168 11:29:21 INFO - 2015-11-17 11:29:21,799 DEBUG : BROWSER_OUTPUT: 11:29:24 INFO - 2015-11-17 11:29:24,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51223/tests/kraken/driver.html?testName=audio-beat-detection) 11:29:25 INFO - 2015-11-17 11:29:25,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 259932160 11:29:25 INFO - 2015-11-17 11:29:25,338 DEBUG : BROWSER_OUTPUT: 11:29:28 INFO - 2015-11-17 11:29:28,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51223/tests/kraken/driver.html?testName=audio-dft) 11:29:29 INFO - 2015-11-17 11:29:29,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 267632640 11:29:29 INFO - 2015-11-17 11:29:29,028 DEBUG : BROWSER_OUTPUT: 11:29:32 INFO - 2015-11-17 11:29:32,396 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51223/tests/kraken/driver.html?testName=audio-fft) 11:29:32 INFO - 2015-11-17 11:29:32,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 267329536 11:29:32 INFO - 2015-11-17 11:29:32,976 DEBUG : BROWSER_OUTPUT: 11:29:35 INFO - 2015-11-17 11:29:35,188 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51223/tests/kraken/driver.html?testName=audio-oscillator) 11:29:35 INFO - 2015-11-17 11:29:35,778 DEBUG : BROWSER_OUTPUT: RSS: Main: 268128256 11:29:35 INFO - 2015-11-17 11:29:35,778 DEBUG : BROWSER_OUTPUT: 11:29:38 INFO - 2015-11-17 11:29:38,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51223/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:29:38 INFO - 2015-11-17 11:29:38,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 268115968 11:29:38 INFO - 2015-11-17 11:29:38,794 DEBUG : BROWSER_OUTPUT: 11:29:42 INFO - 2015-11-17 11:29:42,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51223/tests/kraken/driver.html?testName=imaging-darkroom) 11:29:42 INFO - 2015-11-17 11:29:42,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 267550720 11:29:42 INFO - 2015-11-17 11:29:42,932 DEBUG : BROWSER_OUTPUT: 11:29:46 INFO - 2015-11-17 11:29:46,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51223/tests/kraken/driver.html?testName=imaging-desaturate) 11:29:47 INFO - 2015-11-17 11:29:47,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 266784768 11:29:47 INFO - 2015-11-17 11:29:47,207 DEBUG : BROWSER_OUTPUT: 11:29:50 INFO - 2015-11-17 11:29:50,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51223/tests/kraken/driver.html?testName=json-parse-financial) 11:29:51 INFO - 2015-11-17 11:29:51,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 267923456 11:29:51 INFO - 2015-11-17 11:29:51,095 DEBUG : BROWSER_OUTPUT: 11:29:52 INFO - 2015-11-17 11:29:52,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51223/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:29:53 INFO - 2015-11-17 11:29:53,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 266252288 11:29:53 INFO - 2015-11-17 11:29:53,506 DEBUG : BROWSER_OUTPUT: 11:29:55 INFO - 2015-11-17 11:29:55,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51223/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:29:56 INFO - 2015-11-17 11:29:56,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 267722752 11:29:56 INFO - 2015-11-17 11:29:56,195 DEBUG : BROWSER_OUTPUT: 11:29:58 INFO - 2015-11-17 11:29:58,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51223/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:29:59 INFO - 2015-11-17 11:29:59,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 267513856 11:29:59 INFO - 2015-11-17 11:29:59,192 DEBUG : BROWSER_OUTPUT: 11:30:02 INFO - 2015-11-17 11:30:02,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:30:02 INFO - 2015-11-17 11:30:02,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 267907072 11:30:02 INFO - 2015-11-17 11:30:02,805 DEBUG : BROWSER_OUTPUT: 11:30:05 INFO - 2015-11-17 11:30:05,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:30:06 INFO - 2015-11-17 11:30:06,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 268673024 11:30:06 INFO - 2015-11-17 11:30:06,395 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51223/tests/kraken/driver.html?testName=ai-astar) 11:30:08 INFO - 2015-11-17 11:30:08,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 268677120 11:30:08 INFO - 2015-11-17 11:30:08,590 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,590 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:30:08 INFO - 2015-11-17 11:30:08,590 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:30:08 INFO - 2015-11-17 11:30:08,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:30:08 INFO - 2015-11-17 11:30:08,591 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:30:08 INFO - 2015-11-17 11:30:08,591 DEBUG : BROWSER_OUTPUT: |0;ai-astar;136;127;142;142;140;147;133;134;134;141 11:30:08 INFO - 2015-11-17 11:30:08,591 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;187;172;193;204;163;187;185;157;205;165 11:30:08 INFO - 2015-11-17 11:30:08,591 DEBUG : BROWSER_OUTPUT: |2;audio-dft;197;212;209;205;200;201;202;201;210;209 11:30:08 INFO - 2015-11-17 11:30:08,592 DEBUG : BROWSER_OUTPUT: |3;audio-fft;88;88;99;150;86;87;92;91;125;83 11:30:08 INFO - 2015-11-17 11:30:08,592 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;102;109;157;111;114;114;150;108;110;157 11:30:08 INFO - 2015-11-17 11:30:08,592 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;148;149;147;149;149;157;154;150;149;150 11:30:08 INFO - 2015-11-17 11:30:08,592 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;157;165;162;156;156;165;162;157;156;166 11:30:08 INFO - 2015-11-17 11:30:08,592 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;119;135;123;137;126;124;126;117;125;134 11:30:08 INFO - 2015-11-17 11:30:08,592 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;78;80;83;84;85;83;86;96;87;87 11:30:08 INFO - 2015-11-17 11:30:08,593 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;78;84;84;86;87;90;90;97;87;87 11:30:08 INFO - 2015-11-17 11:30:08,593 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;109;109;112;114;112;112;111;108;112;114 11:30:08 INFO - 2015-11-17 11:30:08,593 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;160;173;168;164;163;160;171;156;167;160 11:30:08 INFO - 2015-11-17 11:30:08,593 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;177;191;193;182;193;177;188;189;192;198 11:30:08 INFO - 2015-11-17 11:30:08,593 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;83;87;89;88;93;91;91;90;93;91 11:30:08 INFO - 2015-11-17 11:30:08,593 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:30:08 INFO - 2015-11-17 11:30:08,594 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:30:08 INFO - 2015-11-17 11:30:08,594 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,760 11:30:08 INFO - 2015-11-17 11:30:08,594 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:30:08 INFO - 2015-11-17 11:30:08,594 DEBUG : BROWSER_OUTPUT: __startTimestamp1447788608585__endTimestamp 11:30:08 INFO - 2015-11-17 11:30:08,594 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,594 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:30:08 INFO - 2015-11-17 11:30:08,595 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:30:08 INFO - 2015-11-17 11:30:08,595 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,595 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:137.60 Median:140.50 stddev:5.83 (4.2%) stddev-sans-first:6.16 11:30:08 INFO - 2015-11-17 11:30:08,595 DEBUG : BROWSER_OUTPUT: Values: 136.0 127.0 142.0 142.0 140.0 147.0 133.0 134.0 134.0 141.0 11:30:08 INFO - 2015-11-17 11:30:08,595 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,596 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:181.80 Median:187.00 stddev:16.89 (9.0%) stddev-sans-first:17.81 11:30:08 INFO - 2015-11-17 11:30:08,596 DEBUG : BROWSER_OUTPUT: Values: 187.0 172.0 193.0 204.0 163.0 187.0 185.0 157.0 205.0 165.0 11:30:08 INFO - 2015-11-17 11:30:08,596 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,596 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:204.60 Median:207.00 stddev:5.10 (2.5%) stddev-sans-first:4.61 11:30:08 INFO - 2015-11-17 11:30:08,596 DEBUG : BROWSER_OUTPUT: Values: 197.0 212.0 209.0 205.0 200.0 201.0 202.0 201.0 210.0 209.0 11:30:08 INFO - 2015-11-17 11:30:08,596 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,597 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:98.90 Median:88.00 stddev:21.60 (24.6%) stddev-sans-first:22.55 11:30:08 INFO - 2015-11-17 11:30:08,597 DEBUG : BROWSER_OUTPUT: Values: 88.0 88.0 99.0 150.0 86.0 87.0 92.0 91.0 125.0 83.0 11:30:08 INFO - 2015-11-17 11:30:08,597 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,597 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:123.20 Median:114.00 stddev:22.05 (19.3%) stddev-sans-first:22.02 11:30:08 INFO - 2015-11-17 11:30:08,599 DEBUG : BROWSER_OUTPUT: Values: 102.0 109.0 157.0 111.0 114.0 114.0 150.0 108.0 110.0 157.0 11:30:08 INFO - 2015-11-17 11:30:08,599 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,599 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:150.20 Median:149.50 stddev:3.01 (2.0%) stddev-sans-first:3.09 11:30:08 INFO - 2015-11-17 11:30:08,600 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 147.0 149.0 149.0 157.0 154.0 150.0 149.0 150.0 11:30:08 INFO - 2015-11-17 11:30:08,600 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,600 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:160.20 Median:162.00 stddev:4.21 (2.6%) stddev-sans-first:4.30 11:30:08 INFO - 2015-11-17 11:30:08,600 DEBUG : BROWSER_OUTPUT: Values: 157.0 165.0 162.0 156.0 156.0 165.0 162.0 157.0 156.0 166.0 11:30:08 INFO - 2015-11-17 11:30:08,600 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,600 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:126.60 Median:126.00 stddev:6.72 (5.3%) stddev-sans-first:6.54 11:30:08 INFO - 2015-11-17 11:30:08,601 DEBUG : BROWSER_OUTPUT: Values: 119.0 135.0 123.0 137.0 126.0 124.0 126.0 117.0 125.0 134.0 11:30:08 INFO - 2015-11-17 11:30:08,601 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,601 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:84.90 Median:85.50 stddev:4.86 (5.7%) stddev-sans-first:4.47 11:30:08 INFO - 2015-11-17 11:30:08,601 DEBUG : BROWSER_OUTPUT: Values: 78.0 80.0 83.0 84.0 85.0 83.0 86.0 96.0 87.0 87.0 11:30:08 INFO - 2015-11-17 11:30:08,601 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,601 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:87.00 Median:87.00 stddev:4.92 (5.7%) stddev-sans-first:4.00 11:30:08 INFO - 2015-11-17 11:30:08,602 DEBUG : BROWSER_OUTPUT: Values: 78.0 84.0 84.0 86.0 87.0 90.0 90.0 97.0 87.0 87.0 11:30:08 INFO - 2015-11-17 11:30:08,602 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,602 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:111.30 Median:112.00 stddev:2.06 (1.8%) stddev-sans-first:2.01 11:30:08 INFO - 2015-11-17 11:30:08,602 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 112.0 114.0 112.0 112.0 111.0 108.0 112.0 114.0 11:30:08 INFO - 2015-11-17 11:30:08,602 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,602 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:164.20 Median:165.50 stddev:5.45 (3.3%) stddev-sans-first:5.57 11:30:08 INFO - 2015-11-17 11:30:08,602 DEBUG : BROWSER_OUTPUT: Values: 160.0 173.0 168.0 164.0 163.0 160.0 171.0 156.0 167.0 160.0 11:30:08 INFO - 2015-11-17 11:30:08,603 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,603 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.00 Median:191.50 stddev:7.10 (3.7%) stddev-sans-first:6.32 11:30:08 INFO - 2015-11-17 11:30:08,603 DEBUG : BROWSER_OUTPUT: Values: 177.0 191.0 193.0 182.0 193.0 177.0 188.0 189.0 192.0 198.0 11:30:08 INFO - 2015-11-17 11:30:08,603 DEBUG : BROWSER_OUTPUT: 11:30:08 INFO - 2015-11-17 11:30:08,603 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:89.60 Median:91.00 stddev:3.03 (3.3%) stddev-sans-first:2.06 11:30:08 INFO - 2015-11-17 11:30:08,604 DEBUG : BROWSER_OUTPUT: Values: 83.0 87.0 89.0 88.0 93.0 91.0 91.0 90.0 93.0 91.0 11:30:08 INFO - 2015-11-17 11:30:08,605 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:30:08 INFO - 2015-11-17 11:30:08,605 DEBUG : BROWSER_OUTPUT: 11:30:09 INFO - 2015-11-17 11:30:09,335 INFO : Browser exited with error code: 0 11:30:09 INFO - 2015-11-17 11:30:09,393 INFO : Completed test kraken (00:01:03) 11:30:09 INFO - 2015-11-17 11:30:09,393 INFO : Starting test v8_7 11:30:09 INFO - 2015-11-17 11:30:09,393 DEBUG : operating with platform_type : mac_ 11:30:09 INFO - 2015-11-17 11:30:09,393 INFO : Initialising browser for v8_7 test... 11:30:09 INFO - 2015-11-17 11:30:09,409 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpVx1u5Y/profile http://localhost:51223/getInfo.html 11:30:12 INFO - 2015-11-17 11:30:12,803 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:30:12 INFO - 2015-11-17 11:30:12,803 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:30:12 INFO - 2015-11-17 11:30:12,803 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 11:30:12 INFO - 2015-11-17 11:30:12,803 DEBUG : BROWSER_OUTPUT: __metrics 11:30:13 INFO - 2015-11-17 11:30:13,505 INFO : Browser initialized. 11:30:13 INFO - 2015-11-17 11:30:13,506 INFO : Running cycle 1/1 for v8_7 test... 11:30:13 INFO - 2015-11-17 11:30:13,506 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/tmpVx1u5Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:30:25 INFO - 2015-11-17 11:30:25,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 242335744 11:30:25 INFO - 2015-11-17 11:30:25,732 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51223/tests/v8_7/run.html (next: http://localhost:51223/tests/v8_7/run.html) 11:30:48 INFO - 2015-11-17 11:30:48,641 DEBUG : BROWSER_OUTPUT: RSS: Main: 261181440 11:30:48 INFO - 2015-11-17 11:30:48,641 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,643 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:30:48 INFO - 2015-11-17 11:30:48,643 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:30:48 INFO - 2015-11-17 11:30:48,643 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:30:48 INFO - 2015-11-17 11:30:48,643 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:30:48 INFO - 2015-11-17 11:30:48,643 DEBUG : BROWSER_OUTPUT: |0;Richards;198.57029388403495 11:30:48 INFO - 2015-11-17 11:30:48,643 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;239.46360153256705 11:30:48 INFO - 2015-11-17 11:30:48,643 DEBUG : BROWSER_OUTPUT: |2;Encrypt;379.3626707132018 11:30:48 INFO - 2015-11-17 11:30:48,643 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6863.013698630137 11:30:48 INFO - 2015-11-17 11:30:48,644 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1358.695652173913 11:30:48 INFO - 2015-11-17 11:30:48,644 DEBUG : BROWSER_OUTPUT: |5;Earley;1078.7486515641856 11:30:48 INFO - 2015-11-17 11:30:48,644 DEBUG : BROWSER_OUTPUT: |6;Boyer;15409.09090909091 11:30:48 INFO - 2015-11-17 11:30:48,644 DEBUG : BROWSER_OUTPUT: |7;RegExp;34355.93220338983 11:30:48 INFO - 2015-11-17 11:30:48,644 DEBUG : BROWSER_OUTPUT: |8;Splay;821.0180623973728 11:30:48 INFO - 2015-11-17 11:30:48,645 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6863.013698630137 11:30:48 INFO - 2015-11-17 11:30:48,645 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:30:48 INFO - 2015-11-17 11:30:48,645 DEBUG : BROWSER_OUTPUT: __startTimestamp1447788648642__endTimestamp 11:30:48 INFO - 2015-11-17 11:30:48,645 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,645 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:30:48 INFO - 2015-11-17 11:30:48,645 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:30:48 INFO - 2015-11-17 11:30:48,646 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,646 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:198.57 Median:198.57 stddev:0.00 (0.0%) 11:30:48 INFO - 2015-11-17 11:30:48,646 DEBUG : BROWSER_OUTPUT: Values: 198.6 11:30:48 INFO - 2015-11-17 11:30:48,646 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,647 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:239.46 Median:239.46 stddev:0.00 (0.0%) 11:30:48 INFO - 2015-11-17 11:30:48,647 DEBUG : BROWSER_OUTPUT: Values: 239.5 11:30:48 INFO - 2015-11-17 11:30:48,647 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,648 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:379.36 Median:379.36 stddev:0.00 (0.0%) 11:30:48 INFO - 2015-11-17 11:30:48,649 DEBUG : BROWSER_OUTPUT: Values: 379.4 11:30:48 INFO - 2015-11-17 11:30:48,649 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,649 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6863.01 Median:6863.01 stddev:0.00 (0.0%) 11:30:48 INFO - 2015-11-17 11:30:48,649 DEBUG : BROWSER_OUTPUT: Values: 6863.0 11:30:48 INFO - 2015-11-17 11:30:48,649 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,649 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1358.70 Median:1358.70 stddev:0.00 (0.0%) 11:30:48 INFO - 2015-11-17 11:30:48,649 DEBUG : BROWSER_OUTPUT: Values: 1358.7 11:30:48 INFO - 2015-11-17 11:30:48,650 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,650 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 11:30:48 INFO - 2015-11-17 11:30:48,650 DEBUG : BROWSER_OUTPUT: Values: 1078.7 11:30:48 INFO - 2015-11-17 11:30:48,650 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,650 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15409.09 Median:15409.09 stddev:0.00 (0.0%) 11:30:48 INFO - 2015-11-17 11:30:48,650 DEBUG : BROWSER_OUTPUT: Values: 15409.1 11:30:48 INFO - 2015-11-17 11:30:48,650 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,650 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34355.93 Median:34355.93 stddev:0.00 (0.0%) 11:30:48 INFO - 2015-11-17 11:30:48,651 DEBUG : BROWSER_OUTPUT: Values: 34355.9 11:30:48 INFO - 2015-11-17 11:30:48,651 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,651 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:821.02 Median:821.02 stddev:0.00 (0.0%) 11:30:48 INFO - 2015-11-17 11:30:48,651 DEBUG : BROWSER_OUTPUT: Values: 821.0 11:30:48 INFO - 2015-11-17 11:30:48,651 DEBUG : BROWSER_OUTPUT: 11:30:48 INFO - 2015-11-17 11:30:48,651 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6863.01 Median:6863.01 stddev:0.00 (0.0%) 11:30:48 INFO - 2015-11-17 11:30:48,651 DEBUG : BROWSER_OUTPUT: Values: 6863.0 11:30:48 INFO - 2015-11-17 11:30:48,651 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:30:48 INFO - 2015-11-17 11:30:48,651 DEBUG : BROWSER_OUTPUT: 11:30:49 INFO - 2015-11-17 11:30:49,410 INFO : Browser exited with error code: 0 11:30:49 INFO - 2015-11-17 11:30:49,433 INFO : Completed test v8_7 (00:00:40) 11:30:49 INFO - 2015-11-17 11:30:49,554 INFO : Completed test suite (00:20:16) 11:30:49 INFO - 2015-11-17 11:30:49,555 DEBUG : Working with test: dromaeo_css 11:30:49 INFO - 2015-11-17 11:30:49,555 DEBUG : Generating results file: dromaeo_css 11:30:49 INFO - 2015-11-17 11:30:49,556 DEBUG : Working with test: kraken 11:30:49 INFO - 2015-11-17 11:30:49,556 DEBUG : Generating results file: kraken 11:30:49 INFO - 2015-11-17 11:30:49,556 INFO : javascript benchmark 11:30:49 INFO - 2015-11-17 11:30:49,556 DEBUG : Working with test: v8_7 11:30:49 INFO - 2015-11-17 11:30:49,556 DEBUG : Generating results file: v8_7 11:30:49 INFO - 2015-11-17 11:30:49,557 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:30:49 INFO - 2015-11-17 11:30:49,611 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,63,57]] 11:30:49 INFO - 2015-11-17 11:30:49,611 DEBUG : process_Request line: dromaeo_css 5592.34 graph.html#tests=[[72,63,57]] 11:30:49 INFO - 2015-11-17 11:30:49,611 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:30:49 INFO - 2015-11-17 11:30:49,640 DEBUG : process_Request line: kraken 1908.10 graph.html#tests=[[232,63,57]] 11:30:49 INFO - 2015-11-17 11:30:49,640 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:30:49 INFO - 2015-11-17 11:30:49,669 DEBUG : process_Request line: v8_7 16093.60 graph.html#tests=[[230,63,57]] 11:30:49 INFO - 2015-11-17 11:30:49,670 INFO : javascript benchmark 11:30:49 INFO - 2015-11-17 11:30:49,672 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2522.1424715596695, 2545.1473756291643, 2603.336149281934, 2626.0939975708384, 2685.9731402685966, 4307.353896915464, 4324.524302326746, 4357.716748411355, 4360.694751367406, 4374.431323927889, 4314.223439780838, 4397.076613911075, 4404.405405270288, 4471.843485478009, 4537.160625284317, 3989.4614227079337, 3997.7401468904573, 4086.83652653895, 4089.9795501022454, 4144.8963775905695, 4064.5325787534516, 4101.118259574191, 4159.355299928516, 4174.749515029108, 4206.326987681971, 3820.4842346283176, 3853.6339047790693, 3929.096307849211, 3999.680025597945, 4012.478377810895, 4007.6192761687594, 4014.6788256939376, 4090.1001779608437, 4114.506259248879, 4125.50493940729, 3969.7221194516396, 3998.0, 4045.797710114512, 4063.3701776224734, 4093.5292441369324, 4140.523839758436, 4169.541350451448, 4334.263175260214, 4407.669424793154, 4416.050549131952, 4554.931676024862, 4659.347691323217, 4669.7898594562985, 4708.246680531099, 4713.457952335491, 4450.488193857683, 4718.811247550094, 4737.73942433166, 4763.309320148559, 4783.545563171493, 4300.11847571244, 4301.07526881722, 4315.3742707307265, 4323.027318853233, 4398.186335527937, 4777.402824646919, 4845.830395936196, 4865.781039853215, 4874.610031197567, 4907.754612269372, 4402.471703395613, 4532.410786597788, 4622.098690755338, 4646.140464014168, 4685.390899183152, 4473.0, 4603.49361570227, 4631.861044168681, 4638.397008388888, 4657.068586282757, 4557.361969324297, 4569.954300456953, 4646.186917289461, 4647.953520464752, 4655.743934083658, 4444.044530425974, 4539.409876716072, 4609.861704148814, 4611.354410382549, 4633.2818413146015, 3547.485614585922, 3572.160542272564, 3606.1705807664384, 3629.8185090745355, 3636.090977255686, 3268.9019329420157, 3273.3780581689402, 3282.901512954615, 3305.752068594865, 3330.9833450833075, 4294.184105020036, 4380.408644832971, 4440.156370289635, 4444.022315090675, 4535.7732113394195, 4659.534046595381, 4733.597644200213, 4780.235162374003, 4782.665213435026, 4827.565519103227, 4436.955630443719, 4491.438570178728, 4492.056668099735, 4492.101579684077, 4498.482674492409, 4069.1658210066867, 4094.9181016379507, 4137.97931010343, 4140.4617399737845, 4211.684123690736, 4766.97510035344, 4779.330893674958, 4856.878578035577, 4885.706857588556, 4939.703617782944, 4486.349479325545, 4755.239161734106, 4786.569208771228, 4803.927941080957, 4846.80612775485, 4790.377250957354, 4798.640101992434, 4846.927296090491, 4875.609951203966, 4959.801607935642, 4636.026434448803, 4672.6495512837355, 4679.649026323107, 4691.202495575829, 4844.588210002189, 4595.954040459686, 4733.810647574059, 4768.3085952537385, 4785.928211076767, 4790.616750660009, 4466.821327146878, 4562.019165879352, 4606.88482787933, 4618.838340658195, 4641.489436161952, 4570.931436028529, 4572.428446444194, 4598.540145985375, 4649.209634362234, 4663.230566956414, 4121.979390103031, 4225.704200705921, 4358.847440339573, 4516.412866327357, 4530.388397566287, 4534.931976020428, 4540.455145382575, 4572.268437050056, 4581.473130589891, 4618.330342100309, 4471.754053526957, 4498.865034048984, 4504.211762941407, 4509.210888094504, 4539.364488971481], "unit": "ms", "name": "dojo.html", "value": 4331.976239284551}, {"lowerIsBetter": false, "replicates": [452.45479197566954, 470.02938931107263, 476.36643264458274, 490.2254437987978, 506.13450998792064, 29792.702072979264, 30944.535831962483, 31079.37841243174, 31084.689153108462, 31411.0, 34601.30797384051, 35521.28957420857, 35743.999999999935, 36095.27809443816, 36241.45637815435, 7503.7748867534065, 7649.04386951631, 7657.923420765805, 7733.41999350051, 7734.110577283628, 7684.769456916273, 7724.304812566867, 7734.0, 7793.025871766029, 7877.566733829637, 7686.231376862325, 7690.730824421146, 7698.499597526171, 7747.496412733154, 7807.336376408012, 7618.885716714254, 7655.770326890174, 7670.846583068335, 7725.49784264021, 7758.262965018314, 7517.0, 7661.272179142972, 7701.537907725555, 7704.3451306639, 7754.18581048993, 32097.197570060704, 32736.508952365733, 32825.50761738576, 33107.6689233107, 33221.50167747486, 2282.155602427096, 2414.8913298901593, 2446.60854263317, 2616.7252438493874, 2843.260752204421, 22227.44431389212, 22338.329850104525, 22606.095756169732, 22876.313710588707, 23232.53534929292, 1930.4884205685505, 1934.6517626827165, 1941.417574727576, 1965.980340196594, 2011.2960463837685, 221616.0, 224688.0, 225511.0, 227834.0, 229467.0, 47533.0, 49273.50726492761, 50417.74791126021, 51279.487205128215, 51606.22590661143, 46653.76673116613, 46959.5304046962, 47045.0, 47102.0, 48043.27935080977, 13803.792943105862, 14079.507217247346, 14130.71738565223, 14144.00991930555, 14181.0, 10405.375677459377, 10527.631532896312, 10584.841227381596, 10703.1437485001, 10704.250702450909, 16558.503244902673, 16839.74740378895, 16983.150842457828, 17041.659166816844, 17049.0, 7285.599292038883, 7448.106227252764, 7450.0687414073245, 7562.848743025109, 7581.810454738676, 707.2856415020866, 741.1513816679872, 747.7980945144889, 764.7820371194183, 795.8647030004913, 23355.0, 23465.88267058654, 23739.40651483727, 23889.7611023891, 24080.51838963211, 877.9683871451147, 931.8089791592707, 943.8725772020827, 988.960441582343, 1027.1166796554958, 11781.930841495207, 11787.233829801207, 11859.407029648655, 12045.156839021185, 12051.819222711667, 330433.0, 335243.0, 337251.0, 342452.0, 342503.0, 44263.55736442594, 45245.32132018022, 45252.09495810131, 45442.77278613586, 45879.54120458753, 1173.8180582009802, 1185.1230089733535, 1186.8991135753386, 1187.2283016039644, 1199.346356235836, 22016.559668806214, 22622.095116195826, 22740.4314892129, 22820.885895570416, 22950.426239343484, 37257.254854903294, 37796.24407511889, 37900.62099378971, 38307.2338553233, 38328.23343533058, 250460.0, 253460.0, 253469.0, 258145.0, 259469.0, 26224.21327360182, 35632.82183589169, 37729.62270377261, 37888.242235155696, 37917.0, 34600.48099278563, 35066.12334691551, 35330.11674708153, 35500.467492988144, 35687.82156089203, 28801.423971520035, 29338.706612933598, 29879.0, 30149.75338232662, 30314.696853031186, 29157.271068223465, 29670.0, 29752.702472974994, 29924.0, 30219.546706799854, 29092.418151637274, 29540.556891647073, 29811.403771924008, 30237.244068898453, 30254.697453025186, 25758.484830303663, 26468.205953821416, 26709.19872403831, 26852.32869178208, 27286.317842054108, 20184.49538761543, 20462.0, 20465.05147611316, 20472.79527204709, 20846.0], "unit": "ms", "name": "ext.html", "value": 15521.444966782574}, {"lowerIsBetter": false, "replicates": [280.15253857082325, 282.0241962808682, 284.1206465987767, 286.95121829289025, 290.08767426443836, 12803.359832008386, 14307.499237526688, 14844.109353438802, 14921.179335136563, 15231.923840380783, 14612.4885629003, 14725.852741472581, 14735.26323683817, 14854.925725371386, 15130.319135638894, 4387.890302742425, 4477.776111194444, 4617.699849509788, 4658.697184682985, 4660.603848672867, 4562.315652652095, 4579.564941330568, 4582.6104781093645, 4583.885402864938, 4616.8153273869, 3223.774335796495, 4078.877633670995, 4584.656150788687, 4621.145088158684, 5119.974400127994, 4947.406311242674, 4997.925031124536, 5018.2974383586325, 5022.698638081709, 5057.291979122944, 4070.816813243411, 4079.836806527765, 4081.1225586499045, 4239.7668128252935, 4358.803853826554, 16756.58108547296, 17592.824071759245, 17666.470005899715, 18256.995865227407, 18436.631267374712, 1385.0512399006714, 1505.9698806023819, 1508.2684897824547, 1554.6968341173476, 1763.3475614022766, 7746.264104910025, 7783.805404864867, 7964.203579642048, 8016.238457346542, 8043.356531477468, 1259.716563773153, 1281.398252184769, 1283.5250957145822, 1297.5393735223954, 1305.3342795174528, 47986.520134798906, 49168.0, 49334.25998610024, 50214.0, 50283.0, 5302.840914772563, 5338.973305133527, 5398.298221231294, 5400.351957765093, 5455.018096742624, 6029.216201893813, 6102.267727872683, 6117.541184411187, 6136.8953588354525, 6143.600665956698, 4516.23224051912, 4535.138323718483, 4566.178087944136, 4567.132244873464, 4572.337011133433, 4914.287428322873, 4949.133901567211, 4966.975165124223, 4977.352944117241, 4990.575801056951, 2395.4610212702, 2412.4210189554733, 2421.503591763684, 2447.2902858170933, 2452.3256104571387, 848.4612271207704, 851.7529916324321, 867.4665080975154, 873.4366333714719, 918.4213945214606, 314.07035175879196, 315.8136699347396, 320.3177232494771, 347.725585728308, 390.79678567144924, 8367.874481882776, 8816.691415800417, 9527.285453591008, 9810.16613587853, 9858.704238872846, 374.6964958383718, 381.1253173965755, 383.9174577465858, 389.05653789560205, 389.7057721420309, 5113.974430127825, 5352.705601191894, 5364.329458817648, 5426.67439953604, 5443.074677304868, 465946.0, 484170.0, 485311.0, 488363.0, 504987.3279779249, 55231.72384138054, 62567.0, 63160.36839631545, 64225.67887160534, 65992.0, 404.561051259381, 413.9834406623701, 417.6533477213905, 419.7607363802603, 424.07551537647606, 8733.432326898732, 8834.867476987978, 8895.332850036144, 9000.144986226298, 9019.503927284062, 29874.103776886728, 30055.519806054766, 30302.848485758313, 30392.0, 31071.68928310688, 42018.0, 42180.15639687128, 42363.1527369457, 43122.568774311854, 43125.56874431216, 5076.898462030813, 5142.382914050338, 5155.9742201290255, 5190.221466779863, 5233.345831771028, 9099.272058235192, 9810.215182785218, 9826.459544725109, 9841.507924603884, 9995.350302230332, 7090.468214883801, 8132.30875375576, 8510.82978340442, 8572.314214862921, 8583.18459746323, 7981.1619779924595, 8201.26188643025, 8252.133525979925, 8391.66433342684, 8456.069832318317, 8348.624311905858, 8481.067082620782, 8535.871961920451, 8676.522791246542, 8779.034306226438, 5048.59611231108, 5164.431912489548, 5165.638405311592, 5191.662541934762, 5235.58639167415, 8485.109063548485, 8494.193051660082, 8642.78393040179, 8644.092370301028, 8668.176523230282], "unit": "ms", "name": "jquery.html", "value": 5796.858663905071}, {"lowerIsBetter": false, "replicates": [1146.0831334932057, 1190.4880901212475, 1201.2612243470264, 1222.541546919905, 1244.3964677131592, 5725.169850371693, 5916.319623243328, 6318.494520438366, 6677.198736151657, 6718.89921651175, 6217.5025997920175, 6250.843728906768, 6332.968335158329, 6351.650659213741, 6416.230052393707, 1860.8139186081385, 1895.2419032387018, 1903.0674969265099, 1915.6264528416964, 1925.951851203717, 1809.1677828199045, 1903.3528600275904, 1936.9031548422593, 1948.298612499499, 1958.8432925365937, 1908.5610309628794, 1915.9904200478977, 1926.210253795944, 1940.41787463761, 1944.1542928825936, 1822.4532640207951, 1852.0832188066927, 1861.3485280151974, 1877.962440751191, 1894.2991093295432, 1856.4337876947525, 1857.117869012222, 1867.2251015828415, 1887.6790945539153, 1919.1267973072218, 6389.872202555969, 6411.551191416603, 6424.0, 6472.546921715481, 6482.513811464159, 4143.8964025899295, 4177.164567086595, 4220.198162349144, 4227.471566054243, 4270.444842170529, 2423.551642946061, 2433.8661373624445, 2451.9509609807706, 2467.3584867934464, 2511.4349271413967, 723.2333726250191, 746.5856449670431, 751.3087959077661, 753.5968256982543, 757.3978686943893, 8721.30229581632, 8734.213920747163, 8789.165029322205, 8835.558222088934, 8867.246284065863, 3740.706899736842, 3761.7931013794505, 3803.7717736935874, 3810.1046254130256, 3839.251345987506, 7433.219511951167, 7499.550026998398, 7509.0, 7538.396928245727, 7582.0, 4159.168166366739, 4159.313713237342, 4216.219999300078, 4218.6414154797185, 4220.261454245495, 3296.241864371208, 3411.249525104473, 3784.6783023443318, 3816.9427458588143, 3835.290471262825, 2993.236724635248, 3076.86154123065, 3089.4902341113466, 3091.8144911305394, 3106.813591184536, 976.9462679552693, 992.8064027514565, 996.1383403356045, 996.6910257820099, 1004.9799004019878, 798.4331124901269, 800.3357213512887, 808.6765293882377, 809.2433574607761, 951.2247518272724, 6045.183900173421, 6046.123312119806, 6049.425304596057, 6058.0610005449225, 6079.939200608026, 926.6571368593663, 957.6552441121191, 961.6586111930304, 966.4346357380871, 971.121135372489, 4681.414823147106, 4822.517748225149, 4851.417829860439, 4863.7324947128245, 4876.561109500091, 7403.074615673041, 7478.326950574366, 7510.436717246228, 7548.735794247175, 7619.504732192389, 7426.888596671054, 7476.177620461854, 7484.064491938508, 7489.325960663567, 7535.208803075599, 6054.182685337511, 6103.542234332532, 6105.419985101408, 6124.35694252106, 6180.412860778219, 5950.761969521171, 5989.580729349078, 6025.427584379477, 6029.547783916311, 6078.756849726138, 6572.8356791080605, 6731.1922569292, 6731.427828634621, 6754.831129221809, 6817.113775209191, 6835.043093966948, 6977.302269772982, 6987.266337034742, 6990.685419156252, 7028.121484814398, 5310.8141215057285, 5469.015577196143, 5731.942680573307, 5826.960563802635, 5848.8887111448685, 5948.821535353946, 6344.270408903035, 6352.523560732871, 6375.808725738235, 6404.519661025349, 5705.0, 5723.370429252862, 5841.094630332305, 5950.761969521171, 6006.759729610942, 5781.710914454176, 5782.074868021096, 5890.2342695449315, 5902.2622172228475, 5914.378990205966, 5895.322037965518, 5940.405959404025, 5948.97025514887, 5981.222441082631, 6021.367756385516, 5370.140777475585, 5406.702631355313, 5412.8646783829145, 5461.371942226695, 5467.72661366938, 5407.78368865241, 5424.457554244544, 5454.427285135003, 5483.122700367922, 5530.806421775219], "unit": "ms", "name": "mootools.html", "value": 3713.342876783977}, {"lowerIsBetter": false, "replicates": [252.3514567561367, 257.9793616510678, 266.8572313812111, 268.07647653832555, 270.0655731170151, 5209.947900520993, 5245.527902488775, 5324.627276090675, 5332.986732520823, 5356.866078348044, 5205.115130427826, 5334.67991920485, 5385.7576409061585, 5422.511973922346, 5494.203340515623, 4061.675065994728, 4063.2279866825356, 4083.6528895043957, 4107.79461026949, 4111.013356794363, 4078.8572399966006, 4087.3255912774357, 4104.199681062194, 4113.095119073799, 4118.320477121287, 3848.942265866014, 4038.131801662642, 4052.635262826345, 4110.362893751473, 4112.198121366319, 3982.8406863725418, 4010.83956641734, 4014.0366312085034, 4035.535913369971, 4063.1061166543313, 3387.5257463955068, 3393.1347506385714, 3401.268727223634, 3427.108951672583, 3452.3095380923664, 5045.646804723634, 5170.45710200431, 5183.585313174937, 5241.633085684004, 5269.815556455544, 4445.688801783876, 4481.484629267611, 4487.573680500347, 4499.61753250974, 4524.909501809978, 5590.161475778625, 5609.831705048855, 5648.124540696199, 5658.575606829463, 5709.657420554739, 3662.0661731258624, 3668.486411902309, 3668.6976123476047, 3684.7236457265813, 3695.224002959382, 5728.656280623176, 5743.339515955635, 5849.356570777211, 5869.882602347971, 5879.0, 3740.7942563158745, 3747.38168202249, 3752.6622603965775, 3774.5281839770028, 3779.981100094482, 3820.0640842993644, 3852.6725228355904, 3852.691784657277, 3854.1520865409566, 3876.341022026262, 4477.932831007537, 4489.304157855538, 4494.5730155635165, 4535.546445355504, 4581.610563102107, 5276.155815069647, 5432.565394768409, 5453.563714902798, 5603.719814009283, 5665.801696940587, 1321.8281623388898, 1340.128916204475, 1348.0563605476207, 1360.081944687332, 1367.699106196635, 846.7502086884384, 857.0443954990141, 864.9308055355557, 866.5017614871474, 872.2585802068318, 5271.65734227274, 5399.217113518518, 5448.782048718086, 5452.427495113036, 5458.808941687022, 5838.32859221195, 5845.240118784531, 5850.765969361178, 5891.1457838614015, 5956.7319470623925, 5388.245645609618, 5403.027455058127, 5404.29744133268, 5408.4050754416985, 5486.478784515464, 3083.8766449341774, 3115.501519756828, 3156.636986746508, 3166.920826979344, 3179.030395729325, 5954.10688396744, 6073.0, 6077.665728384893, 6092.634441933409, 6115.4801841843055, 6051.697415129226, 6065.454109130112, 6075.817725468243, 6107.0228763397645, 6126.724297406538, 5881.0, 6039.54703397247, 6059.333473317932, 6101.589872000535, 6132.018876979841, 5908.202392676933, 5922.911156332572, 5941.643501389757, 5955.153902290131, 5997.190379298913, 5798.217240672455, 5799.710014499174, 5819.4180581943165, 5857.765689372548, 5870.26621672291, 6035.0, 6045.848853778515, 6046.425589568984, 6102.603330783662, 6130.785422510191, 3652.4886515887265, 3814.847406103836, 3821.7706937583835, 3823.9044023899623, 3865.053061999828, 5618.213450116905, 5816.331121920864, 5833.708314584169, 5874.823755287348, 5883.999720047516, 5629.437056294338, 5657.094864821609, 5669.262995810518, 5677.574181936288, 5702.0, 5622.409646987171, 5723.656580605177, 5732.742026608896, 5763.077907534775, 5824.825255242349, 5392.892142157213, 5570.387257401601, 5587.217789509391, 5637.379888212211, 5652.88694226105, 5704.401037890962, 5705.087186050212, 5731.111677689964, 5773.624714393551, 5828.446297601721, 5615.522680572197, 5623.578231632726, 5632.887342253214, 5671.574631902541, 5718.885622287614], "unit": "ms", "name": "prototype.html", "value": 4197.145758598859}, {"lowerIsBetter": false, "replicates": [511.7492428709931, 552.9032419326619, 628.2806186915981, 634.8670995005381, 650.2554575011609, 11625.302481851084, 11983.640490785268, 12028.037756979442, 12033.51865925363, 12164.695882602939, 10084.848727269096, 10571.048605625492, 10805.189610779204, 11083.445827708603, 11178.217524773248, 744.970201191953, 761.4859969520579, 763.0995425398028, 768.4812751392816, 768.7693691892438, 740.4076738609118, 747.4805010517692, 747.4954405776107, 748.1060133140899, 756.9091708994928, 777.3004296133469, 783.5259667900923, 783.9294463498284, 784.9529028258294, 785.4148659248867, 755.4296506137886, 774.1832366852968, 776.3711393771035, 776.5263189454429, 776.8679324514818, 571.043502133924, 574.704027425876, 578.6788332475475, 578.713536799287, 578.9752138714493, 10511.264211505199, 10537.473126343728, 10677.679669609925, 10721.249512534127, 10793.946030269877, 8001.1198768135455, 8061.234182752688, 8251.669933202666, 8612.5693715314, 8863.423877448009, 7171.89242161368, 7372.967784510173, 7398.149212840538, 7447.627618619047, 7683.193264707237, 2582.457683886386, 2593.7924966002674, 2657.627932089509, 2661.5874539446418, 2700.9189724308108, 37794.0, 37846.24307513862, 40841.9999999997, 43333.566664333266, 43846.0, 7305.561666300039, 7344.926550734531, 7359.926400735924, 7499.354531191008, 7589.165191828894, 16105.838941610435, 16170.191490425432, 16200.918995405184, 16316.021038737475, 16498.67002659964, 5712.485876271156, 5755.251817263729, 5811.56413268998, 5848.824535263949, 6107.877842443127, 3118.7037231462973, 3120.3135310231714, 3161.65221825599, 3220.6618305077627, 3223.6615155408813, 2430.4652976345174, 2468.8148388870904, 2472.2088931542094, 2494.8627825469775, 2499.800015998716, 352.33760530203057, 360.3351815899661, 362.68084086004677, 364.7592588891319, 371.5411466838452, 453.7073587536021, 455.4739276136068, 468.1736734663322, 480.82209582454715, 528.9047971365192, 5903.291605007426, 6328.9257181373, 6585.835354116185, 6588.769393071219, 6597.175353080865, 455.9890881213897, 466.5660935330176, 473.56432082484196, 487.33722137892437, 493.20347638563464, 2977.940441191164, 2978.2107741448535, 3015.1256135720832, 3016.2308611304416, 3036.6963303669454, 51779.0, 52214.47785522096, 52391.47608523866, 52423.73788131035, 52973.0, 46046.76976615095, 46065.078698425845, 46312.53687463082, 46313.76843115763, 46456.0, 37404.25191496155, 37905.05237369088, 38872.22255554873, 38937.41593876094, 40100.799496002335, 6879.690413931285, 6923.342282483156, 6955.826104347432, 6962.373386395248, 7168.784936451915, 29268.268293291985, 30034.098977030724, 30052.0, 30212.0, 30446.84776576103, 38303.808480957414, 38990.02524936899, 40094.0, 40466.39300410437, 40505.1898962025, 5930.9110363343725, 6137.570370074231, 6138.324784273637, 6277.780277690442, 6279.246490421178, 8313.750587482386, 9002.18485136524, 9032.819343613222, 9316.767080823034, 9685.515724213901, 8663.220310172115, 8873.023967363455, 8914.86627700572, 8917.821643566962, 8921.330900182642, 9013.188813006598, 9067.36528443029, 9118.747194653739, 9146.771330716785, 9157.633694652406, 8814.5592720365, 8900.198982091642, 9045.231155351868, 9149.496777677292, 9287.349885507949, 7577.355924746238, 7742.690292388242, 7810.179931107152, 7957.1644977276555, 8279.793005174919, 7690.083839260009, 7837.373010159287, 7843.56860372685, 7987.880181797162, 8003.159668234985], "unit": "ms", "name": "yui.html", "value": 5034.840867263474}], "name": "dromaeo_css", "value": 5592.336236630209}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [136.0, 127.0, 142.0, 142.0, 140.0, 147.0, 133.0, 134.0, 134.0, 141.0], "unit": "ms", "name": "ai-astar", "value": 137.6}, {"lowerIsBetter": true, "replicates": [187.0, 172.0, 193.0, 204.0, 163.0, 187.0, 185.0, 157.0, 205.0, 165.0], "unit": "ms", "name": "audio-beat-detection", "value": 181.8}, {"lowerIsBetter": true, "replicates": [197.0, 212.0, 209.0, 205.0, 200.0, 201.0, 202.0, 201.0, 210.0, 209.0], "unit": "ms", "name": "audio-dft", "value": 204.6}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 99.0, 150.0, 86.0, 87.0, 92.0, 91.0, 125.0, 83.0], "unit": "ms", "name": "audio-fft", "value": 98.9}, {"lowerIsBetter": true, "replicates": [102.0, 109.0, 157.0, 111.0, 114.0, 114.0, 150.0, 108.0, 110.0, 157.0], "unit": "ms", "name": "audio-oscillator", "value": 123.2}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 147.0, 149.0, 149.0, 157.0, 154.0, 150.0, 149.0, 150.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 150.2}, {"lowerIsBetter": true, "replicates": [157.0, 165.0, 162.0, 156.0, 156.0, 165.0, 162.0, 157.0, 156.0, 166.0], "unit": "ms", "name": "imaging-darkroom", "value": 160.2}, {"lowerIsBetter": true, "replicates": [119.0, 135.0, 123.0, 137.0, 126.0, 124.0, 126.0, 117.0, 125.0, 134.0], "unit": "ms", "name": "imaging-desaturate", "value": 126.6}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 83.0, 84.0, 85.0, 83.0, 86.0, 96.0, 87.0, 87.0], "unit": "ms", "name": "json-parse-financial", "value": 84.9}, {"lowerIsBetter": true, "replicates": [78.0, 84.0, 84.0, 86.0, 87.0, 90.0, 90.0, 97.0, 87.0, 87.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 87.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 112.0, 114.0, 112.0, 112.0, 111.0, 108.0, 112.0, 114.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 111.3}, {"lowerIsBetter": true, "replicates": [160.0, 173.0, 168.0, 164.0, 163.0, 160.0, 171.0, 156.0, 167.0, 160.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 164.2}, {"lowerIsBetter": true, "replicates": [177.0, 191.0, 193.0, 182.0, 193.0, 177.0, 188.0, 189.0, 192.0, 198.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 188.0}, {"lowerIsBetter": true, "replicates": [83.0, 87.0, 89.0, 88.0, 93.0, 91.0, 91.0, 90.0, 93.0, 91.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 89.6}], "name": "kraken", "value": 1908.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [198.57029388403495], "unit": "score", "name": "Richards", "value": 177.78087199999993}, {"lowerIsBetter": false, "replicates": [239.46360153256705], "unit": "score", "name": "DeltaBlue", "value": 276.10876800000005}, {"lowerIsBetter": false, "replicates": [379.3626707132018], "unit": "score", "name": "Encrypt", "value": 701.6531160000003}, {"lowerIsBetter": false, "replicates": [6863.013698630137], "unit": "score", "name": "Decrypt", "value": 38.78485628742515}, {"lowerIsBetter": false, "replicates": [1358.695652173913], "unit": "score", "name": "RayTrace", "value": 544.6319040000002}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "Earley", "value": 617.8112010000002}, {"lowerIsBetter": false, "replicates": [15409.09090909091], "unit": "score", "name": "Boyer", "value": 43.251286135693185}, {"lowerIsBetter": false, "replicates": [34355.93220338983], "unit": "score", "name": "RegExp", "value": 26.51609028120377}, {"lowerIsBetter": false, "replicates": [821.0180623973728], "unit": "score", "name": "Splay", "value": 99.256038}, {"lowerIsBetter": false, "replicates": [6863.013698630137], "unit": "score", "name": "NavierStokes", "value": 216.2315369261477}], "name": "v8_7", "value": 16093.599896883035}]} 11:30:49 INFO - RETURN: dromaeo_css: 5592.34 11:30:49 INFO - RETURN: kraken: 1908.10 11:30:49 INFO - RETURN: v8_7: 16093.60 11:30:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,57]]", "result": "16093.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,57]]", "result": "1908.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,57]]", "result": "5592.34"}}} 11:30:49 INFO - Return code: 0 11:30:49 INFO - # TBPL SUCCESS # 11:30:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:30:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:30:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:30:49 INFO - 2015-11-17 11:30:49.788 screenresolution[1997:20123] starting screenresolution argv=screenresolution get 11:30:49 INFO - 2015-11-17 11:30:49.793 screenresolution[1997:20123] Display 0: 1600x1200x32@60 11:30:49 INFO - 2015-11-17 11:30:49.799 screenresolution[1998:20126] starting screenresolution argv=screenresolution list 11:30:49 INFO - Available Modes on Display 0 11:30:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:30:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:30:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:30:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:30:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:30:50 INFO - Intel HD Graphics 3000: 11:30:50 INFO - Chipset Model: Intel HD Graphics 3000 11:30:50 INFO - Type: GPU 11:30:50 INFO - Bus: Built-In 11:30:50 INFO - VRAM (Total): 512 MB 11:30:50 INFO - VRAM (Dynamic, Max): 10 11:30:50 INFO - Vendor: Intel (0x8086) 11:30:50 INFO - Device ID: 0x0116 11:30:50 INFO - Revision ID: 0x0009 11:30:50 INFO - Displays: 11:30:50 INFO - Display: 11:30:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:30:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:30:50 INFO - Display Serial Number: 1600x1200 60 11:30:50 INFO - Main Display: Yes 11:30:50 INFO - Mirror: Off 11:30:50 INFO - Online: Yes 11:30:50 INFO - Rotation: Supported 11:30:50 INFO - Return code: 0 11:30:50 INFO - Running post-action listener: _resource_record_post_action 11:30:50 INFO - Running post-run listener: _resource_record_post_run 11:30:51 INFO - Total resource usage - Wall time: 1260s; CPU: 30.0%; Read bytes: 4562944; Write bytes: 692080640; Read time: 919; Write time: 63839 11:30:51 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 337123840; Write bytes: 335554560; Read time: 36800; Write time: 6881 11:30:51 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 4562944; Write bytes: 346155008; Read time: 919; Write time: 56349 11:30:51 INFO - Running post-run listener: _upload_blobber_files 11:30:51 INFO - Blob upload gear active. 11:30:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:30:51 INFO - Copying logs to upload dir... 11:30:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.307046 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-17 11:30:51.248710) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 11:30:51.252175) ========= 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.Y9ahx9bEcP/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.iD34s3jT4B/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011044 build_url: 'https://queue.taskcluster.net/v1/task/vYXGVSLGTtq4oUua6c6MgA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 11:30:51.279684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 11:30:51.280016) ========= 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.Y9ahx9bEcP/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.iD34s3jT4B/Listeners TMPDIR=/var/folders/wz/h65mr4vd2pbg1_927ttyb9j400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005322 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 11:30:51.329652) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 11:30:51.329959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 11:30:51.330360) ========= ========= Total master_lag: 3.53 =========