builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0021 starttime: 1448413503.62 results: success (0) buildid: 20151124161231 builduid: 439540b90c354e98b669fc05c2cb9f0b revision: e84368c1f7b7c61f28f60365b64a70fdf3465c08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.620071) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.620793) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.621297) ========= 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.S0DkR0dOK1/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.bi58UaoQn9/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005370 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.643274) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.643617) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.659150) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.659671) ========= 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.S0DkR0dOK1/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.bi58UaoQn9/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005142 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.712826) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.713331) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.713912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.714388) ========= 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.S0DkR0dOK1/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.bi58UaoQn9/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-24 17:05:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.0M=0s 2015-11-24 17:05:03 (33.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171446 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.903949) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.904655) ========= 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.S0DkR0dOK1/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.bi58UaoQn9/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.018630 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:03.954608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 17:05:03.955412) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e84368c1f7b7c61f28f60365b64a70fdf3465c08 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e84368c1f7b7c61f28f60365b64a70fdf3465c08 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.S0DkR0dOK1/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.bi58UaoQn9/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-24 17:05:04,030 truncating revision to first 12 chars 2015-11-24 17:05:04,030 Setting DEBUG logging. 2015-11-24 17:05:04,031 attempt 1/10 2015-11-24 17:05:04,031 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e84368c1f7b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 17:05:05,523 unpacking tar archive at: fx-team-e84368c1f7b7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.733487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 17:05:05.707504) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:05.708087) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:05.722898) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:05.723469) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 17:05:05.724116) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2015-11-24 17:05:05.724595) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.S0DkR0dOK1/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.bi58UaoQn9/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:05:05 INFO - MultiFileLogger online at 20151124 17:05:05 in /builds/slave/test 17:05:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:05:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:05:05 INFO - {'append_to_log': False, 17:05:05 INFO - 'base_work_dir': '/builds/slave/test', 17:05:05 INFO - 'blob_upload_branch': 'Fx-Team', 17:05:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:05:05 INFO - 'branch': 'Fx-Team', 17:05:05 INFO - 'buildbot_json_path': 'buildprops.json', 17:05:05 INFO - 'config_files': ('talos/mac_config.py',), 17:05:05 INFO - 'default_actions': ('clobber', 17:05:05 INFO - 'read-buildbot-config', 17:05:05 INFO - 'download-and-extract', 17:05:05 INFO - 'populate-webroot', 17:05:05 INFO - 'create-virtualenv', 17:05:05 INFO - 'install', 17:05:05 INFO - 'run-tests'), 17:05:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:05:05 INFO - 'download_minidump_stackwalk': True, 17:05:05 INFO - 'download_symbols': 'ondemand', 17:05:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:05:05 INFO - 'tooltool.py': '/tools/tooltool.py', 17:05:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:05:05 INFO - '/tools/misc-python/virtualenv.py')}, 17:05:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:05:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:05:05 INFO - 'installer_path': 'installer.exe', 17:05:05 INFO - 'log_level': 'info', 17:05:05 INFO - 'log_name': 'talos', 17:05:05 INFO - 'log_to_console': True, 17:05:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:05:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:05:05 INFO - 'opt_config_files': (), 17:05:05 INFO - 'pip_index': False, 17:05:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:05:05 INFO - 'cmd': ('bash', 17:05:05 INFO - '-c', 17:05:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:05:05 INFO - 'enabled': True, 17:05:05 INFO - 'halt_on_failure': False, 17:05:05 INFO - 'name': 'check_screen_resolution'},), 17:05:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:05:05 INFO - 'cmd': ('bash', 17:05:05 INFO - '-c', 17:05:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:05:05 INFO - 'enabled': True, 17:05:05 INFO - 'halt_on_failure': False, 17:05:05 INFO - 'name': 'check_screen_resolution'},), 17:05:05 INFO - 'run_cmd_checks_enabled': True, 17:05:05 INFO - 'sps_profile': False, 17:05:05 INFO - 'sps_profile_interval': 0, 17:05:05 INFO - 'suite': 'dromaeojs', 17:05:05 INFO - 'system_bits': '64', 17:05:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:05:05 INFO - 'title': 't-yosemite-r7-0021', 17:05:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:05:05 INFO - 'use_talos_json': True, 17:05:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:05:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:05:05 INFO - 'work_dir': 'build'} 17:05:05 INFO - ##### 17:05:05 INFO - ##### Running clobber step. 17:05:05 INFO - ##### 17:05:05 INFO - Running pre-action listener: _resource_record_pre_action 17:05:05 INFO - Running main action method: clobber 17:05:05 INFO - rmtree: /builds/slave/test/build 17:05:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:05:07 INFO - Running post-action listener: _resource_record_post_action 17:05:07 INFO - ##### 17:05:07 INFO - ##### Running read-buildbot-config step. 17:05:07 INFO - ##### 17:05:07 INFO - Running pre-action listener: _resource_record_pre_action 17:05:07 INFO - Running main action method: read_buildbot_config 17:05:07 INFO - Using buildbot properties: 17:05:07 INFO - { 17:05:07 INFO - "properties": { 17:05:07 INFO - "buildnumber": 21, 17:05:07 INFO - "product": "firefox", 17:05:07 INFO - "script_repo_revision": "production", 17:05:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:05:07 INFO - "repository": "", 17:05:07 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:05:07 INFO - "buildid": "20151124161231", 17:05:07 INFO - "slavename": "t-yosemite-r7-0021", 17:05:07 INFO - "pgo_build": "False", 17:05:07 INFO - "basedir": "/builds/slave/test", 17:05:07 INFO - "project": "", 17:05:07 INFO - "platform": "yosemite_r7", 17:05:07 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:05:07 INFO - "slavebuilddir": "test", 17:05:07 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:05:07 INFO - "branch": "fx-team", 17:05:07 INFO - "repo_path": "integration/fx-team", 17:05:07 INFO - "stage_platform": "macosx64", 17:05:07 INFO - "builduid": "439540b90c354e98b669fc05c2cb9f0b", 17:05:07 INFO - "revision": "e84368c1f7b7c61f28f60365b64a70fdf3465c08" 17:05:07 INFO - }, 17:05:07 INFO - "sourcestamp": { 17:05:07 INFO - "repository": "", 17:05:07 INFO - "hasPatch": false, 17:05:07 INFO - "project": "", 17:05:07 INFO - "branch": "fx-team-macosx64-talos", 17:05:07 INFO - "changes": [ 17:05:07 INFO - { 17:05:07 INFO - "category": null, 17:05:07 INFO - "files": [ 17:05:07 INFO - { 17:05:07 INFO - "url": null, 17:05:07 INFO - "name": "https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 17:05:07 INFO - } 17:05:07 INFO - ], 17:05:07 INFO - "repository": "", 17:05:07 INFO - "rev": "e84368c1f7b7c61f28f60365b64a70fdf3465c08", 17:05:07 INFO - "who": "mdeboer@mozilla.com", 17:05:07 INFO - "when": 1448413298, 17:05:07 INFO - "number": 6702691, 17:05:07 INFO - "comments": "Bug 1227526: Wait for the feedback page to be opened, before closing the window. r=Standard8", 17:05:07 INFO - "project": "", 17:05:07 INFO - "at": "Tue 24 Nov 2015 17:01:38", 17:05:07 INFO - "branch": "fx-team-macosx64-talos", 17:05:07 INFO - "revlink": "", 17:05:07 INFO - "properties": [ 17:05:07 INFO - [ 17:05:07 INFO - "buildid", 17:05:07 INFO - "20151124161231", 17:05:07 INFO - "Change" 17:05:07 INFO - ], 17:05:07 INFO - [ 17:05:07 INFO - "builduid", 17:05:07 INFO - "439540b90c354e98b669fc05c2cb9f0b", 17:05:07 INFO - "Change" 17:05:07 INFO - ], 17:05:07 INFO - [ 17:05:07 INFO - "pgo_build", 17:05:07 INFO - "False", 17:05:07 INFO - "Change" 17:05:07 INFO - ] 17:05:07 INFO - ], 17:05:07 INFO - "revision": "e84368c1f7b7c61f28f60365b64a70fdf3465c08" 17:05:07 INFO - } 17:05:07 INFO - ], 17:05:07 INFO - "revision": "e84368c1f7b7c61f28f60365b64a70fdf3465c08" 17:05:07 INFO - } 17:05:07 INFO - } 17:05:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 17:05:07 INFO - Running post-action listener: _resource_record_post_action 17:05:07 INFO - ##### 17:05:07 INFO - ##### Running download-and-extract step. 17:05:07 INFO - ##### 17:05:07 INFO - Running pre-action listener: _resource_record_pre_action 17:05:07 INFO - Running main action method: download_and_extract 17:05:07 INFO - mkdir: /builds/slave/test/build/tests 17:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:07 INFO - https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:05:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/test_packages.json 17:05:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/test_packages.json 17:05:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:05:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:05:08 INFO - Downloaded 1149 bytes. 17:05:08 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:05:08 INFO - Using the following test package requirements: 17:05:08 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:05:08 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:05:08 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 17:05:08 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:05:08 INFO - u'jsshell-mac.zip'], 17:05:08 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:05:08 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 17:05:08 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:05:08 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:05:08 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 17:05:08 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:05:08 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 17:05:08 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:05:08 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 17:05:08 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 17:05:08 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 17:05:08 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 17:05:08 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:05:08 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')]} 17:05:08 INFO - https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:05:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:05:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:05:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/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 17:05:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/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 17:05:09 INFO - Downloaded 17527642 bytes. 17:05:09 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 17:05:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:05:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:05:12 INFO - Return code: 0 17:05:12 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 17:05:12 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')]} 17:05:12 INFO - https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:05:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:05:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:05:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/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 17:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/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 17:05:13 INFO - Downloaded 17527642 bytes. 17:05:13 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 17:05:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 17:05:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 17:05:16 INFO - Return code: 0 17:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:05:16 INFO - https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:05:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:05:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:05:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/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 17:05:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/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 17:05:47 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip: The read operation timed out 17:05:47 INFO - retry: attempt #1 caught exception: The read operation timed out 17:05:47 INFO - retry: Failed, sleeping 30 seconds before retrying 17:06:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/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 #2 17:06:18 INFO - Downloaded 11130997 bytes. 17:06:18 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 17:06:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 17:06:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 17:06:18 INFO - Return code: 0 17:06:18 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')]} 17:06:18 INFO - https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:06:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:06:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:06:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 17:06:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dc76W9gASI2FWkPUYzY5kQ/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 17:06:21 INFO - Downloaded 109910266 bytes. 17:06:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:06:21 INFO - mkdir: /builds/slave/test/properties 17:06:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:06:21 INFO - Writing to file /builds/slave/test/properties/build_url 17:06:21 INFO - Contents: 17:06:21 INFO - build_url:https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 17:06:21 INFO - Running post-action listener: _resource_record_post_action 17:06:21 INFO - Running post-action listener: set_extra_try_arguments 17:06:21 INFO - ##### 17:06:21 INFO - ##### Running populate-webroot step. 17:06:21 INFO - ##### 17:06:21 INFO - Running pre-action listener: _resource_record_pre_action 17:06:21 INFO - Running main action method: populate_webroot 17:06:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:06:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:06:21 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:06:21 INFO - '../fennec_ids.txt'], 17:06:21 INFO - 'tests': ['tcheck2']}, 17:06:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:06:21 INFO - '--tppagecycles', 17:06:21 INFO - '7'], 17:06:21 INFO - 'tests': ['tsvgm']}}, 17:06:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:06:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:06:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:06:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:06:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:06:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:21 INFO - 'talos_options': ['--e10s'], 17:06:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:21 INFO - 'tests': ['damp', 'tps']}, 17:06:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:21 INFO - 'talos_options': ['--e10s'], 17:06:21 INFO - 'tests': ['damp', 'tps']}, 17:06:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:06:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:21 INFO - 'other': {'tests': ['a11yr', 17:06:21 INFO - 'ts_paint', 17:06:21 INFO - 'tpaint', 17:06:21 INFO - 'sessionrestore', 17:06:21 INFO - 'sessionrestore_no_auto_restore']}, 17:06:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:06:21 INFO - 'tests': ['a11yr', 17:06:21 INFO - 'ts_paint', 17:06:21 INFO - 'tpaint', 17:06:21 INFO - 'sessionrestore', 17:06:21 INFO - 'sessionrestore_no_auto_restore']}, 17:06:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:06:21 INFO - 'tests': ['a11yr', 17:06:21 INFO - 'ts_paint', 17:06:21 INFO - 'tpaint', 17:06:21 INFO - 'sessionrestore', 17:06:21 INFO - 'sessionrestore_no_auto_restore']}, 17:06:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:06:21 INFO - 'tests': ['a11yr', 17:06:21 INFO - 'ts_paint', 17:06:21 INFO - 'tpaint', 17:06:21 INFO - 'sessionrestore', 17:06:21 INFO - 'sessionrestore_no_auto_restore']}, 17:06:21 INFO - 'other_l64': {'tests': ['a11yr', 17:06:21 INFO - 'ts_paint', 17:06:21 INFO - 'tpaint', 17:06:21 INFO - 'sessionrestore', 17:06:21 INFO - 'sessionrestore_no_auto_restore']}, 17:06:21 INFO - 'other_nol64': {'tests': ['a11yr', 17:06:21 INFO - 'ts_paint', 17:06:21 INFO - 'tpaint', 17:06:21 INFO - 'sessionrestore', 17:06:21 INFO - 'sessionrestore_no_auto_restore']}, 17:06:21 INFO - 'svgr': {'tests': ['tsvgx', 17:06:21 INFO - 'tsvgr_opacity', 17:06:21 INFO - 'tart', 17:06:21 INFO - 'tscrollx', 17:06:21 INFO - 'cart']}, 17:06:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:06:21 INFO - 'tests': ['tsvgx', 17:06:21 INFO - 'tsvgr_opacity', 17:06:21 INFO - 'tart', 17:06:21 INFO - 'tscrollx', 17:06:21 INFO - 'cart']}, 17:06:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:21 INFO - 'tests': ['tp5o']}, 17:06:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:21 INFO - 'talos_options': ['--e10s'], 17:06:21 INFO - 'tests': ['tp5o']}, 17:06:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:21 INFO - 'talos_options': ['--xperf_path', 17:06:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:21 INFO - 'tests': ['tp5n']}, 17:06:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:21 INFO - 'talos_options': ['--e10s', 17:06:21 INFO - '--xperf_path', 17:06:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:21 INFO - 'tests': ['tp5n']}}, 17:06:21 INFO - 'talos.zip': {'path': '', 17:06:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:06:21 INFO - Running post-action listener: _resource_record_post_action 17:06:21 INFO - ##### 17:06:21 INFO - ##### Running create-virtualenv step. 17:06:21 INFO - ##### 17:06:21 INFO - Running pre-action listener: _resource_record_pre_action 17:06:21 INFO - Running main action method: create_virtualenv 17:06:21 INFO - Creating virtualenv /builds/slave/test/build/venv 17:06:21 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 17:06:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:06:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:21 INFO - Using real prefix '/tools/python27' 17:06:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:06:22 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:25 INFO - Installing pip.................done. 17:06:25 INFO - Return code: 0 17:06:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107d18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cf5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae0db8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3c9f0>, '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 0x10799bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c2f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/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.bi58UaoQn9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:06:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/Render', 17:06:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:06:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:06:25 INFO - 'HOME': '/Users/cltbld', 17:06:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:06:25 INFO - 'LOGNAME': 'cltbld', 17:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:25 INFO - 'MOZ_NO_REMOTE': '1', 17:06:25 INFO - 'NO_EM_RESTART': '1', 17:06:25 INFO - 'PAGER': '/bin/cat', 17:06:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:25 INFO - 'PWD': '/builds/slave/test', 17:06:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:06:25 INFO - 'SHELL': '/bin/bash', 17:06:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bi58UaoQn9/Listeners', 17:06:25 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 17:06:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:06:25 INFO - 'USER': 'cltbld', 17:06:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:06:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:25 INFO - 'XPC_FLAGS': '0x0', 17:06:25 INFO - 'XPC_SERVICE_NAME': '0', 17:06:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:06:25 INFO - Cleaning up... 17:06:25 INFO - Return code: 0 17:06:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107d18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cf5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae0db8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3c9f0>, '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 0x10799bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c2f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/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.bi58UaoQn9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:06:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:06:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/Render', 17:06:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:06:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:06:25 INFO - 'HOME': '/Users/cltbld', 17:06:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:06:25 INFO - 'LOGNAME': 'cltbld', 17:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:25 INFO - 'MOZ_NO_REMOTE': '1', 17:06:25 INFO - 'NO_EM_RESTART': '1', 17:06:25 INFO - 'PAGER': '/bin/cat', 17:06:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:25 INFO - 'PWD': '/builds/slave/test', 17:06:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:06:25 INFO - 'SHELL': '/bin/bash', 17:06:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bi58UaoQn9/Listeners', 17:06:25 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 17:06:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:06:25 INFO - 'USER': 'cltbld', 17:06:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:06:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:25 INFO - 'XPC_FLAGS': '0x0', 17:06:25 INFO - 'XPC_SERVICE_NAME': '0', 17:06:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:25 INFO - Downloading/unpacking psutil>=0.7.1 17:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:28 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:06:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:06:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:29 INFO - Installing collected packages: psutil 17:06:29 INFO - Running setup.py install for psutil 17:06:29 INFO - building 'psutil._psutil_osx' extension 17:06:29 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 17:06:29 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 17:06:29 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 17:06:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:06:29 INFO - building 'psutil._psutil_posix' extension 17:06:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:06:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:06:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:06:29 INFO - ^ 17:06:29 INFO - 1 warning generated. 17:06:29 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:06:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:29 INFO - Successfully installed psutil 17:06:29 INFO - Cleaning up... 17:06:29 INFO - Return code: 0 17:06:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107d18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cf5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae0db8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3c9f0>, '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 0x10799bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c2f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/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.bi58UaoQn9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:06:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:06:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/Render', 17:06:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:06:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:06:29 INFO - 'HOME': '/Users/cltbld', 17:06:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:06:29 INFO - 'LOGNAME': 'cltbld', 17:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:29 INFO - 'MOZ_NO_REMOTE': '1', 17:06:29 INFO - 'NO_EM_RESTART': '1', 17:06:29 INFO - 'PAGER': '/bin/cat', 17:06:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:29 INFO - 'PWD': '/builds/slave/test', 17:06:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:06:29 INFO - 'SHELL': '/bin/bash', 17:06:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bi58UaoQn9/Listeners', 17:06:29 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 17:06:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:06:29 INFO - 'USER': 'cltbld', 17:06:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:06:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:29 INFO - 'XPC_FLAGS': '0x0', 17:06:29 INFO - 'XPC_SERVICE_NAME': '0', 17:06:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06: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 17:06:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:06:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:06:32 INFO - Installing collected packages: mozsystemmonitor 17:06:32 INFO - Running setup.py install for mozsystemmonitor 17:06:32 INFO - Successfully installed mozsystemmonitor 17:06:32 INFO - Cleaning up... 17:06:32 INFO - Return code: 0 17:06:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:06: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')]} 17:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06: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')]} 17:06:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107d18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cf5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae0db8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3c9f0>, '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 0x10799bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c2f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/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.bi58UaoQn9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:06:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/Render', 17:06:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:06:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:06:32 INFO - 'HOME': '/Users/cltbld', 17:06:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:06:32 INFO - 'LOGNAME': 'cltbld', 17:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:32 INFO - 'MOZ_NO_REMOTE': '1', 17:06:32 INFO - 'NO_EM_RESTART': '1', 17:06:32 INFO - 'PAGER': '/bin/cat', 17:06:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:32 INFO - 'PWD': '/builds/slave/test', 17:06:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:06:32 INFO - 'SHELL': '/bin/bash', 17:06:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bi58UaoQn9/Listeners', 17:06:32 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 17:06:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:06:32 INFO - 'USER': 'cltbld', 17:06:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:06:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:32 INFO - 'XPC_FLAGS': '0x0', 17:06:32 INFO - 'XPC_SERVICE_NAME': '0', 17:06:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:32 INFO - Downloading/unpacking blobuploader==1.2.4 17:06:32 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 17:06:32 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 17:06:32 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 17:06:32 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 17:06:32 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 17:06:32 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 17:06:34 INFO - Downloading blobuploader-1.2.4.tar.gz 17:06:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:06:35 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 17:06:35 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 17:06:35 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 17:06:35 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 17:06:35 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 17:06:35 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 17:06:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:06:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06:35 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 17:06:35 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 17:06:35 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 17:06:35 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 17:06:35 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 17:06:35 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 17:06:36 INFO - Downloading docopt-0.6.1.tar.gz 17:06:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:36 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:36 INFO - Running setup.py install for blobuploader 17:06:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:06:36 INFO - Running setup.py install for requests 17:06:36 INFO - Running setup.py install for docopt 17:06:36 INFO - Successfully installed blobuploader requests docopt 17:06:36 INFO - Cleaning up... 17:06:37 INFO - Return code: 0 17:06:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:37 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 0x107d18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cf5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae0db8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3c9f0>, '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 0x10799bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c2f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/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.bi58UaoQn9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:06:37 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 17:06:37 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 17:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/Render', 17:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:06:37 INFO - 'HOME': '/Users/cltbld', 17:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:06:37 INFO - 'LOGNAME': 'cltbld', 17:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:37 INFO - 'MOZ_NO_REMOTE': '1', 17:06:37 INFO - 'NO_EM_RESTART': '1', 17:06:37 INFO - 'PAGER': '/bin/cat', 17:06:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:37 INFO - 'PWD': '/builds/slave/test', 17:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:06:37 INFO - 'SHELL': '/bin/bash', 17:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bi58UaoQn9/Listeners', 17:06:37 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 17:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:06:37 INFO - 'USER': 'cltbld', 17:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:37 INFO - 'XPC_FLAGS': '0x0', 17:06:37 INFO - 'XPC_SERVICE_NAME': '0', 17:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:37 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-NDiXcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:37 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-vS1HOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:37 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-0qb6Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:37 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-JVPuuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:37 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-YwO5YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:37 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-Eu0mGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:37 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-el9uE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:38 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-bPVqR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:38 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-E_x1Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:38 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-OsQDhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:38 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-PNq4RU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:38 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-5YyBC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:38 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-qQd0qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:38 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-GqDApZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:38 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-Fd4jNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:38 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-0lF_1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:39 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-G0KBuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:39 INFO - Running setup.py install for manifestparser 17:06:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:06:39 INFO - Running setup.py install for mozcrash 17:06:39 INFO - Running setup.py install for mozdebug 17:06:39 INFO - Running setup.py install for mozdevice 17:06:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:06:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:06:39 INFO - Running setup.py install for mozfile 17:06:39 INFO - Running setup.py install for mozhttpd 17:06:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:06:39 INFO - Running setup.py install for mozinfo 17:06:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:06:40 INFO - Running setup.py install for mozInstall 17:06:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:06:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:06:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:06:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:06:40 INFO - Running setup.py install for mozleak 17:06:40 INFO - Running setup.py install for mozlog 17:06:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:06:40 INFO - Running setup.py install for moznetwork 17:06:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:06:40 INFO - Running setup.py install for mozprocess 17:06:40 INFO - Running setup.py install for mozprofile 17:06:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:06:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:06:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:06:41 INFO - Running setup.py install for mozrunner 17:06:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:06:41 INFO - Running setup.py install for mozscreenshot 17:06:41 INFO - Running setup.py install for moztest 17:06:41 INFO - Running setup.py install for mozversion 17:06:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:06:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:41 INFO - Cleaning up... 17:06:41 INFO - Return code: 0 17:06:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:41 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 0x107d18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cf5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae0db8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3c9f0>, '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 0x10799bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c2f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/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.bi58UaoQn9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:06:41 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 17:06:41 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 17:06:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/Render', 17:06:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:06:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:06:41 INFO - 'HOME': '/Users/cltbld', 17:06:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:06:41 INFO - 'LOGNAME': 'cltbld', 17:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:41 INFO - 'MOZ_NO_REMOTE': '1', 17:06:41 INFO - 'NO_EM_RESTART': '1', 17:06:41 INFO - 'PAGER': '/bin/cat', 17:06:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:41 INFO - 'PWD': '/builds/slave/test', 17:06:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:06:41 INFO - 'SHELL': '/bin/bash', 17:06:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bi58UaoQn9/Listeners', 17:06:41 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 17:06:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:06:41 INFO - 'USER': 'cltbld', 17:06:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:06:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:41 INFO - 'XPC_FLAGS': '0x0', 17:06:41 INFO - 'XPC_SERVICE_NAME': '0', 17:06:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:06:41 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-1D68lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:06:42 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)) 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:06:42 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-krdDEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:06:42 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)) 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:06:42 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-ItCTKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:06:42 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)) 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:06:42 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-ia9txZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:06:42 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)) 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:06:42 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-RKBOLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:06:42 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)) 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:06:42 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-rk07Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:06:42 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)) 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:06:42 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-nSDkOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:06:42 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)) 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:06:42 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-maG5f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:06:42 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)) 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:06:42 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-avJvrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:06:42 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)) 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:06:42 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-a9ck48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 17:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:06:42 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-yIYm9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:06:43 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)) 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:06:43 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-xihQo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:06:43 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)) 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:06:43 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-vDpRll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:06:43 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)) 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:06:43 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-2TrTlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:06:43 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)) 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:43 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-wDOfNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:06:43 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)) 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:06:43 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-8GwxmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:06:43 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)) 17:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:06:43 INFO - Running setup.py (path:/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/pip-C1sGS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:06:43 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)) 17:06:43 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)) 17:06:43 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)) 17:06:43 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)) 17:06:43 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)) 17:06:43 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)) 17:06:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:43 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 17:06:45 INFO - Downloading blessings-1.5.1.tar.gz 17:06:45 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 17:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:06:46 INFO - Installing collected packages: blessings 17:06:46 INFO - Running setup.py install for blessings 17:06:46 INFO - Successfully installed blessings 17:06:46 INFO - Cleaning up... 17:06:46 INFO - Return code: 0 17:06:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:06:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:46 INFO - Reading from file tmpfile_stdout 17:06:46 INFO - Current package versions: 17:06:46 INFO - blessings == 1.5.1 17:06:46 INFO - blobuploader == 1.2.4 17:06:46 INFO - docopt == 0.6.1 17:06:46 INFO - manifestparser == 1.1 17:06:46 INFO - mozInstall == 1.12 17:06:46 INFO - mozcrash == 0.16 17:06:46 INFO - mozdebug == 0.1 17:06:46 INFO - mozdevice == 0.47 17:06:46 INFO - mozfile == 1.2 17:06:46 INFO - mozhttpd == 0.7 17:06:46 INFO - mozinfo == 0.9 17:06:46 INFO - mozleak == 0.1 17:06:46 INFO - mozlog == 3.1 17:06:46 INFO - moznetwork == 0.27 17:06:46 INFO - mozprocess == 0.22 17:06:46 INFO - mozprofile == 0.27 17:06:46 INFO - mozrunner == 6.11 17:06:46 INFO - mozscreenshot == 0.1 17:06:46 INFO - mozsystemmonitor == 0.0 17:06:46 INFO - moztest == 0.7 17:06:46 INFO - mozversion == 1.4 17:06:46 INFO - psutil == 3.1.1 17:06:46 INFO - requests == 1.2.3 17:06:46 INFO - wsgiref == 0.1.2 17:06:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:06:46 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')]} 17:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:46 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')]} 17:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:46 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 0x107d18490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107cf5228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faae0db8470>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c3c9f0>, '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 0x10799bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c2f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/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.bi58UaoQn9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:06:46 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 17:06:46 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 17:06:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/Render', 17:06:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:06:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:06:46 INFO - 'HOME': '/Users/cltbld', 17:06:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:06:46 INFO - 'LOGNAME': 'cltbld', 17:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:46 INFO - 'MOZ_NO_REMOTE': '1', 17:06:46 INFO - 'NO_EM_RESTART': '1', 17:06:46 INFO - 'PAGER': '/bin/cat', 17:06:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:06:46 INFO - 'PWD': '/builds/slave/test', 17:06:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:06:46 INFO - 'SHELL': '/bin/bash', 17:06:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bi58UaoQn9/Listeners', 17:06:46 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 17:06:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:06:46 INFO - 'USER': 'cltbld', 17:06:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:06:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:46 INFO - 'XPC_FLAGS': '0x0', 17:06:46 INFO - 'XPC_SERVICE_NAME': '0', 17:06:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:46 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)) 17:06:46 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)) 17:06:46 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)) 17:06:46 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)) 17:06:46 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)) 17:06:46 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)) 17:06:46 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)) 17:06:46 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)) 17:06:46 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)) 17:06:46 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)) 17:06:46 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)) 17:06:46 INFO - Cleaning up... 17:06:46 INFO - Return code: 0 17:06:46 INFO - Running post-action listener: _resource_record_post_action 17:06:46 INFO - Running post-action listener: _start_resource_monitoring 17:06:46 INFO - Starting resource monitoring. 17:06:46 INFO - ##### 17:06:46 INFO - ##### Running install step. 17:06:46 INFO - ##### 17:06:46 INFO - Running pre-action listener: _resource_record_pre_action 17:06:46 INFO - Running main action method: install 17:06:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:06:47 INFO - Reading from file tmpfile_stdout 17:06:47 INFO - Detecting whether we're running mozinstall >=1.0... 17:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:06:47 INFO - Reading from file tmpfile_stdout 17:06:47 INFO - Output received: 17:06:47 INFO - Usage: mozinstall [options] installer 17:06:47 INFO - Options: 17:06:47 INFO - -h, --help show this help message and exit 17:06:47 INFO - -d DEST, --destination=DEST 17:06:47 INFO - Directory to install application into. [default: 17:06:47 INFO - "/builds/slave/test"] 17:06:47 INFO - --app=APP Application being installed. [default: firefox] 17:06:47 INFO - mkdir: /builds/slave/test/build/application 17:06:47 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'] 17:06:47 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 17:07:17 INFO - Reading from file tmpfile_stdout 17:07:17 INFO - Output received: 17:07:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:07:17 INFO - Running post-action listener: _resource_record_post_action 17:07:17 INFO - ##### 17:07:17 INFO - ##### Running run-tests step. 17:07:17 INFO - ##### 17:07:17 INFO - Running pre-action listener: _resource_record_pre_action 17:07:17 INFO - Running main action method: run_tests 17:07:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:07:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:07:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:07:17 INFO - 2015-11-24 17:07:17.791 screenresolution[2027:12451] starting screenresolution argv=screenresolution get 17:07:17 INFO - 2015-11-24 17:07:17.794 screenresolution[2027:12451] Display 0: 1600x1200x32@60 17:07:17 INFO - 2015-11-24 17:07:17.800 screenresolution[2028:12453] starting screenresolution argv=screenresolution list 17:07:17 INFO - Available Modes on Display 0 17:07:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:07:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:07:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:07:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:07:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:07:18 INFO - Intel Iris: 17:07:18 INFO - Chipset Model: Intel Iris 17:07:18 INFO - Type: GPU 17:07:18 INFO - Bus: Built-In 17:07:18 INFO - VRAM (Dynamic, Max): 1536 MB 17:07:18 INFO - Vendor: Intel (0x8086) 17:07:18 INFO - Device ID: 0x0a2e 17:07:18 INFO - Revision ID: 0x0009 17:07:18 INFO - Displays: 17:07:18 INFO - Display: 17:07:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:07:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:07:18 INFO - Display Serial Number: 1600x1200 60 17:07:18 INFO - Main Display: Yes 17:07:18 INFO - Mirror: Off 17:07:18 INFO - Online: Yes 17:07:18 INFO - Rotation: Supported 17:07:18 INFO - Return code: 0 17:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:07:18 INFO - Python 2.7.3 17:07:18 INFO - Return code: 0 17:07:18 INFO - grabbing minidump binary from tooltool 17:07:18 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')]} 17:07:18 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 0x107c3c9f0>, '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 0x10799bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107c2f8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:07:18 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 17:07:18 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 17:07:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:18 INFO - Return code: 0 17:07:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:07:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:07:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:07:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:07:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:07:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--webServer', 'localhost'] in /builds/slave/test/build 17:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0021 --webServer localhost 17:07:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.S0DkR0dOK1/Render', 17:07:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:07:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:07:18 INFO - 'HOME': '/Users/cltbld', 17:07:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:07:18 INFO - 'LOGNAME': 'cltbld', 17:07:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:07:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:18 INFO - 'MOZ_NO_REMOTE': '1', 17:07:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:07:18 INFO - 'NO_EM_RESTART': '1', 17:07:18 INFO - 'PAGER': '/bin/cat', 17:07:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:18 INFO - 'PWD': '/builds/slave/test', 17:07:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:07:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:07:18 INFO - 'SHELL': '/bin/bash', 17:07:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bi58UaoQn9/Listeners', 17:07:18 INFO - 'TMPDIR': '/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/', 17:07:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:07:18 INFO - 'USER': 'cltbld', 17:07:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:07:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:18 INFO - 'XPC_FLAGS': '0x0', 17:07:18 INFO - 'XPC_SERVICE_NAME': '0', 17:07:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:07:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--webServer', 'localhost'] with output_timeout 3600 17:07:18 INFO - mozversion INFO | application_buildid: 20151124161231 17:07:18 INFO - mozversion INFO | application_changeset: e84368c1f7b7c61f28f60365b64a70fdf3465c08 17:07:18 INFO - mozversion INFO | application_display_name: Nightly 17:07:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:18 INFO - mozversion INFO | application_name: Firefox 17:07:18 INFO - mozversion INFO | application_remotingname: firefox 17:07:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:07:18 INFO - mozversion INFO | application_vendor: Mozilla 17:07:18 INFO - mozversion INFO | application_version: 45.0a1 17:07:18 INFO - mozversion INFO | platform_buildid: 20151124161231 17:07:18 INFO - mozversion INFO | platform_changeset: e84368c1f7b7c61f28f60365b64a70fdf3465c08 17:07:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:07:18 INFO - mozversion INFO | platform_version: 45.0a1 17:07:18 INFO - 2015-11-24 17:07:18,338 DEBUG : using testdate: 1448413638 17:07:18 INFO - 2015-11-24 17:07:18,338 DEBUG : actual date: 1448413638 17:07:18 INFO - 2015-11-24 17:07:18,686 INFO : starting webserver on 'localhost:50103' 17:07:18 INFO - 2015-11-24 17:07:18,687 INFO : Starting test suite t-yosemite-r7-0021 17:07:18 INFO - 2015-11-24 17:07:18,687 INFO : Starting test dromaeo_css 17:07:18 INFO - 2015-11-24 17:07:18,687 DEBUG : operating with platform_type : mac_ 17:07:18 INFO - 2015-11-24 17:07:18,688 INFO : Initialising browser for dromaeo_css test... 17:07:18 INFO - 2015-11-24 17:07:18,700 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmpaD7iCl/profile http://localhost:50103/getInfo.html 17:07:20 INFO - 2015-11-24 17:07:20,806 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:07:20 INFO - 2015-11-24 17:07:20,806 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:07:20 INFO - 2015-11-24 17:07:20,806 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:07:20 INFO - 2015-11-24 17:07:20,806 DEBUG : BROWSER_OUTPUT: __metrics 17:07:20 INFO - 2015-11-24 17:07:20,824 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:07:21 INFO - 2015-11-24 17:07:21,449 INFO : Browser initialized. 17:07:21 INFO - 2015-11-24 17:07:21,449 INFO : Running cycle 1/1 for dromaeo_css test... 17:07:21 INFO - 2015-11-24 17:07:21,449 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmpaD7iCl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:07:33 INFO - 2015-11-24 17:07:33,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 225718272 17:07:33 INFO - 2015-11-24 17:07:33,381 DEBUG : BROWSER_OUTPUT: 17:08:24 INFO - 2015-11-24 17:08:24,227 DEBUG : BROWSER_OUTPUT: 1448413704226 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] 17:10:34 INFO - 2015-11-24 17:10:34,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50103/tests/dromaeo/cssquery-ext.html) 17:10:36 INFO - 2015-11-24 17:10:36,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 407756800 17:10:36 INFO - 2015-11-24 17:10:36,400 DEBUG : BROWSER_OUTPUT: 17:13:39 INFO - 2015-11-24 17:13:39,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/dromaeo/cssquery-ext.html (next: http://localhost:50103/tests/dromaeo/cssquery-jquery.html) 17:13:39 INFO - 2015-11-24 17:13:39,746 DEBUG : BROWSER_OUTPUT: RSS: Main: 364068864 17:13:39 INFO - 2015-11-24 17:13:39,747 DEBUG : BROWSER_OUTPUT: 17:16:41 INFO - 2015-11-24 17:16:41,750 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50103/tests/dromaeo/cssquery-mootools.html) 17:16:42 INFO - 2015-11-24 17:16:42,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 339202048 17:16:42 INFO - 2015-11-24 17:16:42,348 DEBUG : BROWSER_OUTPUT: 17:19:44 INFO - 2015-11-24 17:19:44,395 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50103/tests/dromaeo/cssquery-prototype.html) 17:19:44 INFO - 2015-11-24 17:19:44,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 314757120 17:19:44 INFO - 2015-11-24 17:19:44,979 DEBUG : BROWSER_OUTPUT: 17:22:47 INFO - 2015-11-24 17:22:47,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50103/tests/dromaeo/cssquery-yui.html) 17:22:48 INFO - 2015-11-24 17:22:48,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 319410176 17:22:48 INFO - 2015-11-24 17:22:48,556 DEBUG : BROWSER_OUTPUT: 17:25:51 INFO - 2015-11-24 17:25:51,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/dromaeo/cssquery-yui.html (next: http://localhost:50103/tests/dromaeo/cssquery-dojo.html) 17:25:51 INFO - 2015-11-24 17:25:51,405 DEBUG : BROWSER_OUTPUT: RSS: Main: 412213248 17:25:51 INFO - 2015-11-24 17:25:51,405 DEBUG : BROWSER_OUTPUT: 17:25:51 INFO - 2015-11-24 17:25:51,405 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:25:51 INFO - 2015-11-24 17:25:51,405 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:25:51 INFO - 2015-11-24 17:25:51,405 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:25:51 INFO - 2015-11-24 17:25:51,405 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:25:51 INFO - 2015-11-24 17:25:51,406 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3118.9532157017643;3446.190145315852;3459.42919418296;3470.097774578609;3522.682958533733;5548.140038294061;5704.600677952545;5705.087186050233;5762.135679648055;5779.104238842976;5736.684482353469;5743.913841292374;5751.993401154802;5808.854778630536;5916.142159386897;5158.174692049282;5173.249878767577;5191.428942816287;5229.346331708536;5267.868303292429;4799.808007679689;5309.044372013036;5334.226537152111;5340.25236466895;5341.732913354336;5094.694318340893;5189.610779191538;5201.869953251199;5216.634835561512;5256.579473642099;5004.824831130893;5093.923591146136;5108.770105345231;5119.2321151827155;5120.001599688062;5135.152699804527;5174.844754657329;5193.221016847466;5219.164933610642;5225.477452254782;5519.172124181365;5694.117411801178;5729.656220626775;5762.827115186509;5765.336986246593;6066.5945044141135;6176.135341052256;6195.132681424604;6203.627782333075;6226.657533835637;6212;6235.781747638811;6245.6252624842655;6248.468880145193;6252.499800016033;5659.971700141473;5933.139694744238;5951.791687290924;5954.583179177459;5972.432618901197;6143.938560614337;6176.135341052256;6216.720247588779;6255.562110652301;6267.4045965633195;6166.907496387557;6185.721642526097;6204.441600255998;6205.720742566596;6226.968865155736;6084.30030546484;6209.59637623553;6234.875302494015;6242.843928901813;6247.843803904939;6104.26748790148;6113.633182009094;6156.107364432132;6192.009278515416;6203.751849925952;6200.782972595937;6212.47193988516;6221.3778622138325;6221.4089661482085;6222.719977600928;4835.129676658235;4959.330490383824;4973.2042873140845;4976.776045077981;5016.197408414636;4356.934645980313;4459.888502787457;4470.530594287618;4482.932756008662;4519.502854685982;5763.423657634203;5804.738786754606;5810.854728631733;5822.767089316465;5822.796202132905;6076.605020673642;6225.128482012522;6256.0303153011355;6272.780452684134;6281.7173227203975;4920.434150072716;5735.8852822944145;5745.425457454221;5753.309602847685;5847.883042339129;5436.3476382834315;5444.183372494158;5444.646098003617;5448.073827449343;5475.4524547545725;6111.478540206873;6352;6355.459785918156;6357;6362.109304697254;6133.671320645623;6191.690415479118;6208.658523781055;6245.937540624717;6274.717637706223;6312.116303717391;6356.809295721136;6367;6380.330065343258;6385.29761726219;6141.815745527641;6174.753009879554;6185.165002724754;6204.937950620617;6236.594621349598;6051.727672254847;6069.635821850527;6104.38956104386;6186.907196392148;6192.969035154795;6153.3716696182555;6177.907331390123;6200.286966998853;6203.069539569101;6218.906716399348;6208.751649933952;6211.006239001738;6212.440880320612;6218.22272215973;6228.283747369111;5784.739686714192;5968.373320801254;5975.40245975399;5978.432048955342;5986.491148252273;4990.80036798524;6010.33886272501;6060.090986352083;6094.39056094387;6104.542159337979;5613.522850557748;5749.195112684144;5752.338481074563;5754.6259493134485;5996 17:25:51 INFO - 2015-11-24 17:25:51,407 DEBUG : BROWSER_OUTPUT: |1;ext.html;535.5363868302758;552.0174090119583;580.5297708855828;635.9125894720029;650.1483057195074;32980.34039319215;33521.66478335216;33530.49704254438;33559.161020974454;33582.49626255605;44315.77842110793;44679.77660111695;44762;44839;44853.87865303361;9776.90223097767;9996.2502812289;10007.799844003115;10012.499375031255;10017.549210285519;8799.076097009818;8970.86543701845;8986.14631609996;9780.510974451285;9905.059019393146;10198.388096714183;12000.879991200063;12095.21381110225;12115;12129.211601245936;11950.880491195063;11965.162438629299;12019.63941081769;12029.157958942878;12091.395430228453;8856.424332418437;8977.192052715287;8980.55097245135;9790.853137202948;11915.582954596548;44591.77704111491;44925;44928.77535612334;44935.77532112318;45092.3236151458;3224.5002024685978;3343.264481813997;3394.9830250848836;3442.6901578858024;3880.1269714314335;29607;29607.70392296071;30495.54256686129;30605;30642;2811.5360965440677;2818.309514169042;2849.9430011399863;2892.855357232151;2958;495994.52002739755;498250;498303.9999999964;498964;499043;69027;69589;69628.99999999898;69865.65067174734;69895;73136.63431682807;73296.26703732894;73571.63214183894;73615.63192184005;73616;16943;17421.47735567935;17429.738553921703;17449.825501745076;17463.301467941394;13138.934305328412;13165.407556659973;13205.603831885059;13218.074734768667;13238.53665121716;20936.848473334114;21258;21385.78614213838;21387.823669698315;21450.892745536174;8292.502449853027;8483.109273526314;8483.74548763538;8497.915020849712;8513.531755753493;958.4488918871676;970.4807927758616;977.8484334928097;980.3578655980344;1005.0251256281396;28726;29766;29950.95171668981;30251.243718907204;30470.667633164107;954.6706386296717;1085.0776839686202;1094.2559059839386;1186.3890096600257;1209.3311230502027;13940.930295348458;14625.561233163022;14793.778093328609;15073.623159421102;15110.697786044218;438313.6168638337;493999;496462;506984;557836;50206.49793502018;61700.382996169465;62168.689156553926;62182.75634487376;62230.75538489205;1377.1392879450343;1407.4510940733123;1407.73956817989;1452.3464441001802;1454.120257244373;23220.41948951222;23807.809609519107;28819.991300304388;29615.25961850971;30712.385752285278;55471.44528554663;55569;55620.72189639188;55661.16508252299;55664;399596;401826;402047;402414;404468;30104.397912042074;31286;31400.685993139778;31405.685943140277;31508.842455787573;45982.08035839198;46127.76936115298;46171.538284618066;46572.53427465682;47655.76172119117;37753;37981.62018379781;38812.41781373338;39161.804190978866;39830.60169398385;31707.682923171396;36124.27751445009;36658.8167059163;36717.89846304615;36916.63083369132;36677.63322366742;36945.07637309089;36961;37767.81116094402;38838.6116138835;26576.601350980138;31156;32839;32871.67128328686;32872.50691239681;24783.87608061948;24865;24916.501669966863;25235.62146567766;25333 17:25:51 INFO - 2015-11-24 17:25:51,408 DEBUG : BROWSER_OUTPUT: |2;jquery.html;363.4675200830784;368.1201927393529;369.77628534736465;370.8090333478259;371.867986864663;16080.251385065776;18250;19534.90232548837;20782.376528704142;21040.158393664253;21397.93010349484;21570.460738481546;21582.13671453144;21598.3520494385;21615.783842161614;4782.952170478303;6637;6838.9658051709675;6839.726410943581;6849.280825513324;4867.586255168315;4897.951020489803;7627.008488896464;7678.500897441649;7692.499987500794;6474.482041436674;7441.330280274774;7465.888011679829;7588.127365352972;7632.809179770522;6325.399087086719;7447.515911465792;7608.429367797437;7622.847543049135;7623.809404764897;7257.274272572753;7271.854562908712;7278.308560686726;7281.235470275651;7373.373263272628;23964.442311249713;24946.50106997868;26961.191164264907;27070;27895.860520697468;2047.396018174642;2176.923807666724;2488.9004439822384;2719.601590842177;2850.900218492343;15537.14545699986;15652.373905043785;15692;15696.90121691482;16365.918170409192;1780.7506949027147;1831.9450416487393;1860.0792607659296;1898.0549634780134;1917.1851962915705;88218;94283.11433771354;103797;106008.99999999923;110314.44842775735;14853.554393368217;18366.54083647893;18861.24555017784;18957.43127706171;19014.239430422906;27791.722082779317;27856.442871142463;27872;27930.02244921418;27935.58096628552;8060.476069055492;8292.37807164465;8302.418830681914;8373.41386102979;10506.947465262625;8446.408751387344;8447.36644751646;8451.408401411842;8462.19609137131;8533.829323413496;4048.919021619551;4156.709030367906;4163.375493675912;4287.914241715148;4305.277888844487;1773.8492228160492;1819.8908065516111;1825.497988053296;1827.168638269584;1829.6798060339388;897.1725171445296;910.9590068446936;972.7665360313474;981.8068220698261;1087.217203613397;17915.73126403079;19737.802621973882;21046.579068418545;21515;21520.246791362228;939.178219058324;952.9237660987104;979.2557656181211;1010.6715317521688;1030.443560477349;9209.631614735335;11110;11157.442127893573;11160.274582152297;11162.330260184415;671023;719598;731698;760577;764737;112755;115565.8443415572;116182;117225.4138729318;120185;1112.7162573543694;1127.3912087472836;1129.836173754801;1140.361397617337;1164.67971307891;18361.54096147607;18408.539786505444;18628.068596569847;18666.346677866208;18715.719264210777;47153.52846471492;49803;50263.74868125636;50265.74867125641;50678;61446.54213831397;67673;70526.29473705402;70935.93596096167;74859.25140748522;9318.161365477139;9652.227821774382;9897.50512474359;9979.251556133464;9981.251406144424;11607.6517704469;19336.613267734287;19383.903080484506;19521.51196220049;20183.09176087109;15485.84514154844;15598.454054108051;15707.214639267762;16016.599585010468;16140.435084771976;15441.5367538974;15480.922595386952;15587;15765.605859853595;15772;12496.812547811973;16648;16967.830321697118;17279.481615551555;17287.481375558753;9902.504874756089;9958.452285124387;9995.67566492867;10013.599456021677;10136.391816491034;10390.740231494274;11542.877682039118;16114.194290285204;16453.753193702345;16582.419615313407 17:25:51 INFO - 2015-11-24 17:25:51,412 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1600.2398860541243;1600.9759853602197;1714.6656402001615;1901.5341241395856;1941.5340318323601;7724.497907636007;7947.562884041383;8104.513729176246;8227.588620568977;8246.670133194664;8351.582420878962;8466.238038576526;8499;8504.532250726208;8513.91486085139;2111.324376199617;2168.176093084626;2357.0453966143696;2383.2254517281867;2385.8329916905823;2068.751749790027;2177.052981952848;2365.5150694107665;2365.515069410775;2394.6767186429784;2330.498942727313;2350.7296660883962;2365.9408514787096;2379.940501487459;2382.7855493005627;2127.723395958531;2159.708439360682;2172.1854304635763;2327.8836058197107;2365.124903785602;2332.125452955142;2384.5350156719446;2387.271882075966;2387.9761202387926;2391.1033362489065;8242.340612750966;8436.789080273042;8445.113263107347;8448.155184481564;8455.577221138918;5103.081445339837;5185.585153187736;5196.29849970253;5225.294585230983;5234.398044224887;3466.480027995796;3514;3604.6034936157002;3607.2244467439364;3608.9458658120147;1051.1905832508926;1053.3100818963592;1064.3986147826454;1067.3755852826107;1081.9883409012598;11170.553177872875;11232.831507527393;11234.719132021764;11235.157363197794;11268.549258029669;4601.309803529431;4686.484486706459;4724.4094488188975;4755.096531658974;4770.212914869007;9697.369670971364;9701.126898579161;9702.078302561245;9708.271879609058;9719.271054670928;5244.213367994831;5248.475152484797;5251.2123181523075;5265.210218467184;5265.947340526623;4755.83354582588;4793.23308270675;4794.760261986887;4800.1119792837735;4810.518948105231;3012.4426981008583;3728.7762734236035;3738.6074462181623;3768.7550309229814;3868.4777555030273;1003.9598416063276;1046.6179844356755;1110.7667389848061;1140.863096428434;1175.9529618815322;1113.0983903038564;1122.8708698499613;1123.4438952718456;1131.9490622921987;1351.803988421693;7966.880496792553;7983.680652773824;8058.798530036796;8062.395320350997;8169.223923727236;1213.7848426621451;1223.113242898909;1234.1792707849359;1274.8533918599294;1276.5595869425033;4546.886327841764;6021.217241758631;6052.606580572248;6138.7237574309265;6155.138280640714;10018.749531261778;10063.295569310078;10234.48827558619;10327.431991240404;10327.896721032694;10143.594256229668;10221.897781022244;10234.181265498743;10250.38497690141;10263.973602639677;7870.488418252795;7930.246626570467;7957.442978991531;8047.637856296364;8078.757637270891;7915.84168316642;7967.282944534788;7968.442209045543;7980.960095199487;8005.719799806979;8979.820403592023;9009.684661036832;9195.586198620944;9300.953495232481;9305.348625596414;8533.573321334032;9368.297377696565;9390.530473476436;9403.858942115738;9475.763105922408;6910.412614927787;6983.1620205575655;7004.579725216503;7006.019157318082;7011.123609548807;7655.196204398458;7957.7612671619945;8047.356211503183;8052.557109358807;8054.23484768946;7421.554706717398;7456.403487721078;7461.738839140604;7532.8493430132185;7644.0827100748265;7171.677274522764;7282.781516554512;7353.8161545961775;7484;7507.286807753255;7408.925296002099;7415.961765352747;7421.2949769771785;7428.517146385468;7465.552066876005;6803.183617965876;6931.202911665223;6953.965230173817;6957.478189135733;6961.860762784615;6353.904691429725;7020.684069216795;7065.788026359218;7068.045813815069;7070.116235470567 17:25:51 INFO - 2015-11-24 17:25:51,413 DEBUG : BROWSER_OUTPUT: |4;prototype.html;322.2732737676539;329.91752061984505;330.58181400528326;337.54431517451445;341.9504171895074;6669.866602667944;6806;6806.3193680631975;6820.181578210615;6835;6784.864302713942;6811.046453496502;6812.863742725155;6830.692618832152;6831.453483721303;4871.780769865364;4997.350344455216;5008.724520151409;5012.799488020475;5048.798048078091;4877.02459508098;4956.330895329139;5014.473480284572;5014.648974571782;5017.996400719852;4052.5542190359038;4972.353594032788;4984.202527595586;5014.022265658198;5015.899682006358;3801.3917773156163;4959.429665588467;4967.006598680278;4967.528084831935;4982.128127577677;4263.91472170558;4264.829406823724;4269.082147338306;4272.03879127197;4273.059926816096;6279.309275979638;6538.313477084886;6544.869102617969;6551.574147680433;6554.213494380705;5874.618149820248;5911.940880591225;5914.319853216892;5921.200637913869;5927.9703601481715;6919.8962015569805;7181.569105853613;7295.854082918365;7302.1967583565765;7328;3923.038855480397;4656.115338085753;4717.716936983792;4832.685875418122;4833.419989601235;7728.420368472387;7768.57272849993;7785.90997260384;7809.531428114331;7823.374130069581;3993.7603743775467;4592.747398893026;4896.681715688469;4907.582855457326;4917.0903382874285;4804.327394164819;4813.95186048142;4816.446108697474;4816.8554943351055;4831.685940413862;4727;5917.260342457193;5917.940820591739;5924.259467566554;5928.466438020512;5685.658860468385;7393.038904942323;7399.223081576357;7417.851642967111;7419.369353604896;1632.3225861267679;1674.6566953774447;1678.6139187986832;1684.9241784119745;1686.6542358816414;899.3884158771967;902.891653001644;1057.645688694296;1082.118073769875;1087.4780105549223;6750.223724271674;6775.085363475966;6796.422304104207;6798.184217893884;6821.147356580427;6091.482224011009;6224.692814509004;7617.466777325645;7627.618619069135;7644.503107298008;6189.876202475925;6553.57401768893;6603;6773.390394864387;6868.416184624263;2924.736773690378;3154.9588635750147;4033.878983630496;4035.455213546192;4050.25070361984;7532.209118042636;7887.526748395115;7905.762827115196;7910.920890791133;7939.483933544417;6351.587146835441;7740.690372385042;7857.646405911633;7894.842103157905;8050.31572316348;7698.653560589675;8020.157883422274;8037.919620803717;8042.115367309591;8051.154628763896;7521.661525231269;7626.521380551232;7627.733029343946;7633.160352361125;7638.694452222071;7595.392368610608;7617.466777325534;7630.694772209272;7631.1605723369275;7631.771046868603;7790.026246719161;8004;8021.27808497238;8025.638846251816;8029.357651387758;4748.240281554935;4777.474477807369;4807.975960120177;4808.182608956416;4810.39870016248;7689.077310722525;7694.846103078019;7695.923040769745;7696.461247712607;7696.8075798103255;7141.892871607034;7413.703451861865;7416.480846340704;7424.406047516294;7426.071741032371;7383.114026316662;7386.446016548888;7394.408447324308;7398.482106252511;7402.555846649003;6975.895361569479;7214.206437291999;7221.4222862169845;7230.74692385764;7237.819054523468;7424.740134095497;7426.962865185639;7430;7443.404527637667;7450.92549074524;7224.963875180591;7240.312170343809;7241;7244.891326630211;7253.274672532915 17:25:51 INFO - 2015-11-24 17:25:51,415 DEBUG : BROWSER_OUTPUT: |5;yui.html;739.5525706947296;807.1041144329793;807.7940125268055;822.1901427094311;826.9627866745996;15387.153706546136;15455.45905893294;15492.380304787823;15501.302441390137;15507.534773956786;14155;14255.429782808675;14294.857051429482;14310.926680498953;14314.498992535264;770.299027884625;781.9687212511493;782.6947490478718;950;981.8429051351785;961.125375907924;961.4759955824057;974.5663179884954;974.9220062395027;979.5787811241163;1005.2008653120787;1026.2251999740186;1028.804527139841;1030.6856408795315;1031.0102301790291;798.8362385710944;815.8980127484065;1004.9799004019915;1011.701548043329;1029.6756521695643;757.8825282081286;765.7013764631798;768.0744702633314;768.7117331000875;769.3268390158611;12237.816432753516;14559.272036398137;14660.340284687214;14805.481808136663;14817;12383.876161238362;12957.09300348976;12982.415791289415;13126.85980434115;13322.86677133226;10247.538860751283;10288.537015834305;10309.329893556895;10321.535530901128;10352.327098738633;3552.928941421157;3597.6042635310355;3603.045193023851;3603.8017909015257;3605.8737944171826;80075.5996220021;80483.5975820123;81002.59498702468;81882.59058704728;82089.17910820874;9729.221662267002;9787.265955053399;9951.80096398068;9969.55137018836;10453.21600879937;21380;21605.891970540048;21624;21642.35072947814;21668.4582885426;7004.229534751174;7165.140183177948;7188.820279493055;7274.1634712007735;7354.043974283309;3935.2326296371934;3998.4002399639703;4002.2995975704134;4005.3991901214467;4015.658669013108;3535;3575.982120089435;3576.8211589420425;3587.874424395186;3587.892363229107;647.5531883000715;653.8136631060125;662.8309781005813;664.5447868210291;665.6139439125295;454.86808825440914;481.1795888010933;493.4399456616766;516.9508896654812;529.4520171622353;7995.617202480242;8667;8741.388102832869;8881.911180888237;9044.457332560067;570.7374607680431;577.0910815465659;581.3169525807244;591.5888457522067;627.3882964109956;4024.557298697141;4053.0272734544087;4205.936910946339;4322.524522302544;4502.482214545304;82587.58706206431;83263;84114.15885841186;88285.11714882769;88318.55840720884;75381.62309188419;76364.85452718213;77088.22911770923;77784;78796.42407151825;67592;67802.66098669475;68343;68528.31471685319;69735.65132174306;8964.68623598171;8972.641094356153;8972.68595599177;8980.281577473917;9072.637094516145;48771.75614121907;48938.77653058702;49033.75483122562;49081.50918490912;49791.00417991693;63354.68322658357;67342;69355;70260.59478810293;70631;10752.677419677422;10964;10973.890261097287;11173.441327933408;11377.2604780689;11424.942875285571;11711.590094346657;12151.088668350087;12431.564895228623;12480.251184928933;11178.653349781323;11473.885261147281;11789.174757767218;11839.763204735686;12293.737143423557;10990.340579565252;11487.310761354345;11743.647690569296;12276.017918566671;12282.692932676397;10875.40185289785;11406;11517.193796434169;11559.595414160463;12093.818592721293;9433.952830235805;9697.224222062077;9753.366031207948;9762.658306959222;10227.386356818615;9270.304727145356;9338.85279670408;9994.350367226398;10013.649522266685;10035.197184225099 17:25:51 INFO - 2015-11-24 17:25:51,415 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:25:51 INFO - 2015-11-24 17:25:51,415 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:25:51 INFO - 2015-11-24 17:25:51,415 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1598 17:25:51 INFO - 2015-11-24 17:25:51,415 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:25:51 INFO - 2015-11-24 17:25:51,415 DEBUG : BROWSER_OUTPUT: __startTimestamp1448414751401__endTimestamp 17:25:51 INFO - 2015-11-24 17:25:51,415 DEBUG : BROWSER_OUTPUT: 17:25:51 INFO - 2015-11-24 17:25:51,415 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:25:51 INFO - 2015-11-24 17:25:51,416 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:25:51 INFO - 2015-11-24 17:25:51,416 DEBUG : BROWSER_OUTPUT: 17:25:51 INFO - 2015-11-24 17:25:51,417 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5740.18 Median:5975.40 stddev:638.89 (10.7%) stddev-sans-first:606.85 17:25:51 INFO - 2015-11-24 17:25:51,417 DEBUG : BROWSER_OUTPUT: Values: 3119.0 3446.2 3459.4 3470.1 3522.7 5548.1 5704.6 5705.1 5762.1 5779.1 5736.7 5743.9 5752.0 5808.9 5916.1 5158.2 5173.2 5191.4 5229.3 5267.9 4799.8 5309.0 5334.2 5340.3 5341.7 5094.7 5189.6 5201.9 5216.6 5256.6 5004.8 5093.9 5108.8 5119.2 5120.0 5135.2 5174.8 5193.2 5219.2 5225.5 5519.2 5694.1 5729.7 5762.8 5765.3 6066.6 6176.1 6195.1 6203.6 6226.7 6212.0 6235.8 6245.6 6248.5 6252.5 5660.0 5933.1 5951.8 5954.6 5972.4 6143.9 6176.1 6216.7 6255.6 6267.4 6166.9 6185.7 6204.4 6205.7 6227.0 6084.3 6209.6 6234.9 6242.8 6247.8 6104.3 6113.6 6156.1 6192.0 6203.8 6200.8 6212.5 6221.4 6221.4 6222.7 4835.1 4959.3 4973.2 4976.8 5016.2 4356.9 4459.9 4470.5 4482.9 4519.5 5763.4 5804.7 5810.9 5822.8 5822.8 6076.6 6225.1 6256.0 6272.8 6281.7 4920.4 5735.9 5745.4 5753.3 5847.9 5436.3 5444.2 5444.6 5448.1 5475.5 6111.5 6352.0 6355.5 6357.0 6362.1 6133.7 6191.7 6208.7 6245.9 6274.7 6312.1 6356.8 6367.0 6380.3 6385.3 6141.8 6174.8 6185.2 6204.9 6236.6 6051.7 6069.6 6104.4 6186.9 6193.0 6153.4 6177.9 6200.3 6203.1 6218.9 6208.8 6211.0 6212.4 6218.2 6228.3 5784.7 5968.4 5975.4 5978.4 5986.5 4990.8 6010.3 6060.1 6094.4 6104.5 5613.5 5749.2 5752.3 5754.6 5996.0 17:25:51 INFO - 2015-11-24 17:25:51,417 DEBUG : BROWSER_OUTPUT: 17:25:51 INFO - 2015-11-24 17:25:51,418 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:62536.12 Median:36668.22 stddev:124451.95 (339.4%) stddev-sans-first:124714.01 17:25:51 INFO - 2015-11-24 17:25:51,419 DEBUG : BROWSER_OUTPUT: Values: 535.5 552.0 580.5 635.9 650.1 32980.3 33521.7 33530.5 33559.2 33582.5 44315.8 44679.8 44762.0 44839.0 44853.9 9776.9 9996.3 10007.8 10012.5 10017.5 8799.1 8970.9 8986.1 9780.5 9905.1 10198.4 12000.9 12095.2 12115.0 12129.2 11950.9 11965.2 12019.6 12029.2 12091.4 8856.4 8977.2 8980.6 9790.9 11915.6 44591.8 44925.0 44928.8 44935.8 45092.3 3224.5 3343.3 3395.0 3442.7 3880.1 29607.0 29607.7 30495.5 30605.0 30642.0 2811.5 2818.3 2849.9 2892.9 2958.0 495994.5 498250.0 498304.0 498964.0 499043.0 69027.0 69589.0 69629.0 69865.7 69895.0 73136.6 73296.3 73571.6 73615.6 73616.0 16943.0 17421.5 17429.7 17449.8 17463.3 13138.9 13165.4 13205.6 13218.1 13238.5 20936.8 21258.0 21385.8 21387.8 21450.9 8292.5 8483.1 8483.7 8497.9 8513.5 958.4 970.5 977.8 980.4 1005.0 28726.0 29766.0 29951.0 30251.2 30470.7 954.7 1085.1 1094.3 1186.4 1209.3 13940.9 14625.6 14793.8 15073.6 15110.7 438313.6 493999.0 496462.0 506984.0 557836.0 50206.5 61700.4 62168.7 62182.8 62230.8 1377.1 1407.5 1407.7 1452.3 1454.1 23220.4 23807.8 28820.0 29615.3 30712.4 55471.4 55569.0 55620.7 55661.2 55664.0 399596.0 401826.0 402047.0 402414.0 404468.0 30104.4 31286.0 31400.7 31405.7 31508.8 45982.1 46127.8 46171.5 46572.5 47655.8 37753.0 37981.6 38812.4 39161.8 39830.6 31707.7 36124.3 36658.8 36717.9 36916.6 36677.6 36945.1 36961.0 37767.8 38838.6 26576.6 31156.0 32839.0 32871.7 32872.5 24783.9 24865.0 24916.5 25235.6 25333.0 17:25:51 INFO - 2015-11-24 17:25:51,419 DEBUG : BROWSER_OUTPUT: 17:25:51 INFO - 2015-11-24 17:25:51,419 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39130.89 Median:13226.67 stddev:119926.27 (906.7%) stddev-sans-first:120227.36 17:25:51 INFO - 2015-11-24 17:25:51,420 DEBUG : BROWSER_OUTPUT: Values: 363.5 368.1 369.8 370.8 371.9 16080.3 18250.0 19534.9 20782.4 21040.2 21397.9 21570.5 21582.1 21598.4 21615.8 4783.0 6637.0 6839.0 6839.7 6849.3 4867.6 4898.0 7627.0 7678.5 7692.5 6474.5 7441.3 7465.9 7588.1 7632.8 6325.4 7447.5 7608.4 7622.8 7623.8 7257.3 7271.9 7278.3 7281.2 7373.4 23964.4 24946.5 26961.2 27070.0 27895.9 2047.4 2176.9 2488.9 2719.6 2850.9 15537.1 15652.4 15692.0 15696.9 16365.9 1780.8 1831.9 1860.1 1898.1 1917.2 88218.0 94283.1 103797.0 106009.0 110314.4 14853.6 18366.5 18861.2 18957.4 19014.2 27791.7 27856.4 27872.0 27930.0 27935.6 8060.5 8292.4 8302.4 8373.4 10506.9 8446.4 8447.4 8451.4 8462.2 8533.8 4048.9 4156.7 4163.4 4287.9 4305.3 1773.8 1819.9 1825.5 1827.2 1829.7 897.2 911.0 972.8 981.8 1087.2 17915.7 19737.8 21046.6 21515.0 21520.2 939.2 952.9 979.3 1010.7 1030.4 9209.6 11110.0 11157.4 11160.3 11162.3 671023.0 719598.0 731698.0 760577.0 764737.0 112755.0 115565.8 116182.0 117225.4 120185.0 1112.7 1127.4 1129.8 1140.4 1164.7 18361.5 18408.5 18628.1 18666.3 18715.7 47153.5 49803.0 50263.7 50265.7 50678.0 61446.5 67673.0 70526.3 70935.9 74859.3 9318.2 9652.2 9897.5 9979.3 9981.3 11607.7 19336.6 19383.9 19521.5 20183.1 15485.8 15598.5 15707.2 16016.6 16140.4 15441.5 15480.9 15587.0 15765.6 15772.0 12496.8 16648.0 16967.8 17279.5 17287.5 9902.5 9958.5 9995.7 10013.6 10136.4 10390.7 11542.9 16114.2 16453.8 16582.4 17:25:51 INFO - 2015-11-24 17:25:51,420 DEBUG : BROWSER_OUTPUT: 17:25:51 INFO - 2015-11-24 17:25:51,420 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5846.72 Median:5239.31 stddev:3056.14 (58.3%) stddev-sans-first:3048.05 17:25:51 INFO - 2015-11-24 17:25:51,421 DEBUG : BROWSER_OUTPUT: Values: 1600.2 1601.0 1714.7 1901.5 1941.5 7724.5 7947.6 8104.5 8227.6 8246.7 8351.6 8466.2 8499.0 8504.5 8513.9 2111.3 2168.2 2357.0 2383.2 2385.8 2068.8 2177.1 2365.5 2365.5 2394.7 2330.5 2350.7 2365.9 2379.9 2382.8 2127.7 2159.7 2172.2 2327.9 2365.1 2332.1 2384.5 2387.3 2388.0 2391.1 8242.3 8436.8 8445.1 8448.2 8455.6 5103.1 5185.6 5196.3 5225.3 5234.4 3466.5 3514.0 3604.6 3607.2 3608.9 1051.2 1053.3 1064.4 1067.4 1082.0 11170.6 11232.8 11234.7 11235.2 11268.5 4601.3 4686.5 4724.4 4755.1 4770.2 9697.4 9701.1 9702.1 9708.3 9719.3 5244.2 5248.5 5251.2 5265.2 5265.9 4755.8 4793.2 4794.8 4800.1 4810.5 3012.4 3728.8 3738.6 3768.8 3868.5 1004.0 1046.6 1110.8 1140.9 1176.0 1113.1 1122.9 1123.4 1131.9 1351.8 7966.9 7983.7 8058.8 8062.4 8169.2 1213.8 1223.1 1234.2 1274.9 1276.6 4546.9 6021.2 6052.6 6138.7 6155.1 10018.7 10063.3 10234.5 10327.4 10327.9 10143.6 10221.9 10234.2 10250.4 10264.0 7870.5 7930.2 7957.4 8047.6 8078.8 7915.8 7967.3 7968.4 7981.0 8005.7 8979.8 9009.7 9195.6 9301.0 9305.3 8533.6 9368.3 9390.5 9403.9 9475.8 6910.4 6983.2 7004.6 7006.0 7011.1 7655.2 7957.8 8047.4 8052.6 8054.2 7421.6 7456.4 7461.7 7532.8 7644.1 7171.7 7282.8 7353.8 7484.0 7507.3 7408.9 7416.0 7421.3 7428.5 7465.6 6803.2 6931.2 6954.0 6957.5 6961.9 6353.9 7020.7 7065.8 7068.0 7070.1 17:25:51 INFO - 2015-11-24 17:25:51,421 DEBUG : BROWSER_OUTPUT: 17:25:51 INFO - 2015-11-24 17:25:51,422 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5954.09 Median:6797.30 stddev:1967.90 (29.0%) stddev-sans-first:1927.49 17:25:51 INFO - 2015-11-24 17:25:51,422 DEBUG : BROWSER_OUTPUT: Values: 322.3 329.9 330.6 337.5 342.0 6669.9 6806.0 6806.3 6820.2 6835.0 6784.9 6811.0 6812.9 6830.7 6831.5 4871.8 4997.4 5008.7 5012.8 5048.8 4877.0 4956.3 5014.5 5014.6 5018.0 4052.6 4972.4 4984.2 5014.0 5015.9 3801.4 4959.4 4967.0 4967.5 4982.1 4263.9 4264.8 4269.1 4272.0 4273.1 6279.3 6538.3 6544.9 6551.6 6554.2 5874.6 5911.9 5914.3 5921.2 5928.0 6919.9 7181.6 7295.9 7302.2 7328.0 3923.0 4656.1 4717.7 4832.7 4833.4 7728.4 7768.6 7785.9 7809.5 7823.4 3993.8 4592.7 4896.7 4907.6 4917.1 4804.3 4814.0 4816.4 4816.9 4831.7 4727.0 5917.3 5917.9 5924.3 5928.5 5685.7 7393.0 7399.2 7417.9 7419.4 1632.3 1674.7 1678.6 1684.9 1686.7 899.4 902.9 1057.6 1082.1 1087.5 6750.2 6775.1 6796.4 6798.2 6821.1 6091.5 6224.7 7617.5 7627.6 7644.5 6189.9 6553.6 6603.0 6773.4 6868.4 2924.7 3155.0 4033.9 4035.5 4050.3 7532.2 7887.5 7905.8 7910.9 7939.5 6351.6 7740.7 7857.6 7894.8 8050.3 7698.7 8020.2 8037.9 8042.1 8051.2 7521.7 7626.5 7627.7 7633.2 7638.7 7595.4 7617.5 7630.7 7631.2 7631.8 7790.0 8004.0 8021.3 8025.6 8029.4 4748.2 4777.5 4808.0 4808.2 4810.4 7689.1 7694.8 7695.9 7696.5 7696.8 7141.9 7413.7 7416.5 7424.4 7426.1 7383.1 7386.4 7394.4 7398.5 7402.6 6975.9 7214.2 7221.4 7230.7 7237.8 7424.7 7427.0 7430.0 7443.4 7450.9 7225.0 7240.3 7241.0 7244.9 7253.3 17:25:51 INFO - 2015-11-24 17:25:51,422 DEBUG : BROWSER_OUTPUT: 17:25:51 INFO - 2015-11-24 17:25:51,422 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18135.21 Median:48986.27 stddev:24980.67 (51.0%) stddev-sans-first:25016.60 17:25:51 INFO - 2015-11-24 17:25:51,424 DEBUG : BROWSER_OUTPUT: Values: 739.6 807.1 807.8 822.2 827.0 15387.2 15455.5 15492.4 15501.3 15507.5 14155.0 14255.4 14294.9 14310.9 14314.5 770.3 782.0 782.7 950.0 981.8 961.1 961.5 974.6 974.9 979.6 1005.2 1026.2 1028.8 1030.7 1031.0 798.8 815.9 1005.0 1011.7 1029.7 757.9 765.7 768.1 768.7 769.3 12237.8 14559.3 14660.3 14805.5 14817.0 12383.9 12957.1 12982.4 13126.9 13322.9 10247.5 10288.5 10309.3 10321.5 10352.3 3552.9 3597.6 3603.0 3603.8 3605.9 80075.6 80483.6 81002.6 81882.6 82089.2 9729.2 9787.3 9951.8 9969.6 10453.2 21380.0 21605.9 21624.0 21642.4 21668.5 7004.2 7165.1 7188.8 7274.2 7354.0 3935.2 3998.4 4002.3 4005.4 4015.7 3535.0 3576.0 3576.8 3587.9 3587.9 647.6 653.8 662.8 664.5 665.6 454.9 481.2 493.4 517.0 529.5 7995.6 8667.0 8741.4 8881.9 9044.5 570.7 577.1 581.3 591.6 627.4 4024.6 4053.0 4205.9 4322.5 4502.5 82587.6 83263.0 84114.2 88285.1 88318.6 75381.6 76364.9 77088.2 77784.0 78796.4 67592.0 67802.7 68343.0 68528.3 69735.7 8964.7 8972.6 8972.7 8980.3 9072.6 48771.8 48938.8 49033.8 49081.5 49791.0 63354.7 67342.0 69355.0 70260.6 70631.0 10752.7 10964.0 10973.9 11173.4 11377.3 11424.9 11711.6 12151.1 12431.6 12480.3 11178.7 11473.9 11789.2 11839.8 12293.7 10990.3 11487.3 11743.6 12276.0 12282.7 10875.4 11406.0 11517.2 11559.6 12093.8 9434.0 9697.2 9753.4 9762.7 10227.4 9270.3 9338.9 9994.4 10013.6 10035.2 17:25:51 INFO - 2015-11-24 17:25:51,424 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:25:51 INFO - 2015-11-24 17:25:51,424 DEBUG : BROWSER_OUTPUT: 17:25:51 INFO - 2015-11-24 17:25:51,897 INFO : Browser exited with error code: 0 17:25:51 INFO - 2015-11-24 17:25:51,922 INFO : Completed test dromaeo_css (00:18:33) 17:25:51 INFO - 2015-11-24 17:25:51,922 INFO : Starting test kraken 17:25:51 INFO - 2015-11-24 17:25:51,922 DEBUG : operating with platform_type : mac_ 17:25:51 INFO - 2015-11-24 17:25:51,922 INFO : Initialising browser for kraken test... 17:25:51 INFO - 2015-11-24 17:25:51,934 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmppM28Z7/profile http://localhost:50103/getInfo.html 17:25:53 INFO - 2015-11-24 17:25:53,952 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:25:53 INFO - 2015-11-24 17:25:53,952 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:25:53 INFO - 2015-11-24 17:25:53,952 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:25:53 INFO - 2015-11-24 17:25:53,952 DEBUG : BROWSER_OUTPUT: __metrics 17:25:53 INFO - 2015-11-24 17:25:53,970 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:25:54 INFO - 2015-11-24 17:25:54,825 INFO : Browser initialized. 17:25:54 INFO - 2015-11-24 17:25:54,826 INFO : Running cycle 1/1 for kraken test... 17:25:54 INFO - 2015-11-24 17:25:54,826 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmppM28Z7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:26:06 INFO - 2015-11-24 17:26:06,756 DEBUG : BROWSER_OUTPUT: RSS: Main: 227131392 17:26:06 INFO - 2015-11-24 17:26:06,756 DEBUG : BROWSER_OUTPUT: 17:26:09 INFO - 2015-11-24 17:26:09,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50103/tests/kraken/driver.html?testName=audio-beat-detection) 17:26:09 INFO - 2015-11-24 17:26:09,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 276635648 17:26:09 INFO - 2015-11-24 17:26:09,970 DEBUG : BROWSER_OUTPUT: 17:26:12 INFO - 2015-11-24 17:26:12,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50103/tests/kraken/driver.html?testName=audio-dft) 17:26:13 INFO - 2015-11-24 17:26:13,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 290287616 17:26:13 INFO - 2015-11-24 17:26:13,161 DEBUG : BROWSER_OUTPUT: 17:26:16 INFO - 2015-11-24 17:26:16,394 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50103/tests/kraken/driver.html?testName=audio-fft) 17:26:16 INFO - 2015-11-24 17:26:16,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 279011328 17:26:16 INFO - 2015-11-24 17:26:16,976 DEBUG : BROWSER_OUTPUT: 17:26:18 INFO - 2015-11-24 17:26:18,938 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50103/tests/kraken/driver.html?testName=audio-oscillator) 17:26:19 INFO - 2015-11-24 17:26:19,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 281731072 17:26:19 INFO - 2015-11-24 17:26:19,528 DEBUG : BROWSER_OUTPUT: 17:26:21 INFO - 2015-11-24 17:26:21,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50103/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:22 INFO - 2015-11-24 17:26:22,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 283525120 17:26:22 INFO - 2015-11-24 17:26:22,109 DEBUG : BROWSER_OUTPUT: 17:26:24 INFO - 2015-11-24 17:26:24,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50103/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:25 INFO - 2015-11-24 17:26:25,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 282521600 17:26:25 INFO - 2015-11-24 17:26:25,491 DEBUG : BROWSER_OUTPUT: 17:26:28 INFO - 2015-11-24 17:26:28,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50103/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:28 INFO - 2015-11-24 17:26:28,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 284110848 17:26:28 INFO - 2015-11-24 17:26:28,841 DEBUG : BROWSER_OUTPUT: 17:26:31 INFO - 2015-11-24 17:26:31,494 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50103/tests/kraken/driver.html?testName=json-parse-financial) 17:26:32 INFO - 2015-11-24 17:26:32,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 283598848 17:26:32 INFO - 2015-11-24 17:26:32,095 DEBUG : BROWSER_OUTPUT: 17:26:33 INFO - 2015-11-24 17:26:33,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50103/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:34 INFO - 2015-11-24 17:26:34,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 317952000 17:26:34 INFO - 2015-11-24 17:26:34,166 DEBUG : BROWSER_OUTPUT: 17:26:35 INFO - 2015-11-24 17:26:35,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50103/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:36 INFO - 2015-11-24 17:26:36,574 DEBUG : BROWSER_OUTPUT: RSS: Main: 319799296 17:26:36 INFO - 2015-11-24 17:26:36,574 DEBUG : BROWSER_OUTPUT: 17:26:38 INFO - 2015-11-24 17:26:38,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50103/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:39 INFO - 2015-11-24 17:26:39,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 323874816 17:26:39 INFO - 2015-11-24 17:26:39,288 DEBUG : BROWSER_OUTPUT: 17:26:41 INFO - 2015-11-24 17:26:41,765 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:26:42 INFO - 2015-11-24 17:26:42,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 326049792 17:26:42 INFO - 2015-11-24 17:26:42,366 DEBUG : BROWSER_OUTPUT: 17:26:44 INFO - 2015-11-24 17:26:44,778 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:26:45 INFO - 2015-11-24 17:26:45,365 DEBUG : BROWSER_OUTPUT: RSS: Main: 324214784 17:26:45 INFO - 2015-11-24 17:26:45,365 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50103/tests/kraken/driver.html?testName=ai-astar) 17:26:47 INFO - 2015-11-24 17:26:47,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 383975424 17:26:47 INFO - 2015-11-24 17:26:47,442 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,442 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:26:47 INFO - 2015-11-24 17:26:47,442 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:26:47 INFO - 2015-11-24 17:26:47,442 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |0;ai-astar;102;112;115;155;128;109;111;109;109;118 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;120;142;157;118;139;147;144;165;119 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |2;audio-dft;186;219;180;186;184;183;182;185;184;183 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |3;audio-fft;60;70;76;73;56;61;82;101;102;54 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;86;82;117;75;77;75;113;77;74;112 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;86;85;87;85;85;130;132;87;85;90 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;93;93;93;93;93;93;93;93;94 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;87;86;87;85;83;84;86;84;85;86 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;54;54;54;54;54;55;63;52;53 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;65;64;66;66;69;68;68;69;71 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;82;81;81;81;80;79;87;106;107 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;123;128;121;122;120;124;120;118;123 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;147;138;134;137;124;137;136;138;125 17:26:47 INFO - 2015-11-24 17:26:47,443 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;64;64;64;76;75;95;54;88;89;94 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1035 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: __startTimestamp1448414807436__endTimestamp 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:116.80 Median:113.50 stddev:15.08 (13.3%) stddev-sans-first:15.02 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: Values: 102.0 112.0 115.0 155.0 128.0 109.0 111.0 109.0 109.0 118.0 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:139.80 Median:145.50 stddev:16.19 (11.1%) stddev-sans-first:16.96 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: Values: 147.0 120.0 142.0 157.0 118.0 139.0 147.0 144.0 165.0 119.0 17:26:47 INFO - 2015-11-24 17:26:47,444 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:187.20 Median:184.50 stddev:11.32 (6.1%) stddev-sans-first:12.00 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: Values: 186.0 219.0 180.0 186.0 184.0 183.0 182.0 185.0 184.0 183.0 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:73.50 Median:65.50 stddev:17.27 (26.4%) stddev-sans-first:17.61 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: Values: 60.0 70.0 76.0 73.0 56.0 61.0 82.0 101.0 102.0 54.0 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:88.80 Median:76.00 stddev:17.80 (23.4%) stddev-sans-first:18.85 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: Values: 86.0 82.0 117.0 75.0 77.0 75.0 113.0 77.0 74.0 112.0 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:95.20 Median:85.50 stddev:18.94 (22.1%) stddev-sans-first:19.79 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 87.0 85.0 85.0 130.0 132.0 87.0 85.0 90.0 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 94.0 17:26:47 INFO - 2015-11-24 17:26:47,445 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.34 (1.6%) stddev-sans-first:1.27 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: Values: 87.0 86.0 87.0 85.0 83.0 84.0 86.0 84.0 85.0 86.0 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.01 (5.6%) stddev-sans-first:3.19 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: Values: 55.0 54.0 54.0 54.0 54.0 54.0 55.0 63.0 52.0 53.0 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:68.00 stddev:2.36 (3.5%) stddev-sans-first:2.24 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: Values: 64.0 65.0 64.0 66.0 66.0 69.0 68.0 68.0 69.0 71.0 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:81.00 stddev:10.81 (13.4%) stddev-sans-first:11.22 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 81.0 81.0 81.0 80.0 79.0 87.0 106.0 107.0 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:122.50 stddev:2.75 (2.2%) stddev-sans-first:2.89 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: Values: 121.0 123.0 128.0 121.0 122.0 120.0 124.0 120.0 118.0 123.0 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,446 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.00 Median:137.00 stddev:6.62 (4.8%) stddev-sans-first:7.01 17:26:47 INFO - 2015-11-24 17:26:47,447 DEBUG : BROWSER_OUTPUT: Values: 134.0 147.0 138.0 134.0 137.0 124.0 137.0 136.0 138.0 125.0 17:26:47 INFO - 2015-11-24 17:26:47,447 DEBUG : BROWSER_OUTPUT: 17:26:47 INFO - 2015-11-24 17:26:47,447 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:82.00 stddev:14.58 (17.8%) stddev-sans-first:14.77 17:26:47 INFO - 2015-11-24 17:26:47,447 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 76.0 75.0 95.0 54.0 88.0 89.0 94.0 17:26:47 INFO - 2015-11-24 17:26:47,447 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:26:47 INFO - 2015-11-24 17:26:47,447 DEBUG : BROWSER_OUTPUT: 17:26:48 INFO - 2015-11-24 17:26:48,099 INFO : Browser exited with error code: 0 17:26:48 INFO - 2015-11-24 17:26:48,145 INFO : Completed test kraken (00:00:56) 17:26:48 INFO - 2015-11-24 17:26:48,145 INFO : Starting test v8_7 17:26:48 INFO - 2015-11-24 17:26:48,145 DEBUG : operating with platform_type : mac_ 17:26:48 INFO - 2015-11-24 17:26:48,146 INFO : Initialising browser for v8_7 test... 17:26:48 INFO - 2015-11-24 17:26:48,158 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmpD42GsY/profile http://localhost:50103/getInfo.html 17:26:50 INFO - 2015-11-24 17:26:50,365 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:26:50 INFO - 2015-11-24 17:26:50,366 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:26:50 INFO - 2015-11-24 17:26:50,366 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 17:26:50 INFO - 2015-11-24 17:26:50,366 DEBUG : BROWSER_OUTPUT: __metrics 17:26:50 INFO - 2015-11-24 17:26:50,386 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:26:51 INFO - 2015-11-24 17:26:51,052 INFO : Browser initialized. 17:26:51 INFO - 2015-11-24 17:26:51,052 INFO : Running cycle 1/1 for v8_7 test... 17:26:51 INFO - 2015-11-24 17:26:51,053 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/tmpD42GsY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:27:02 INFO - 2015-11-24 17:27:02,856 DEBUG : BROWSER_OUTPUT: RSS: Main: 226709504 17:27:02 INFO - 2015-11-24 17:27:02,856 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50103/tests/v8_7/run.html (next: http://localhost:50103/tests/v8_7/run.html) 17:27:24 INFO - 2015-11-24 17:27:24,547 DEBUG : BROWSER_OUTPUT: RSS: Main: 692609024 17:27:24 INFO - 2015-11-24 17:27:24,547 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,547 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:27:24 INFO - 2015-11-24 17:27:24,547 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:27:24 INFO - 2015-11-24 17:27:24,547 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:27:24 INFO - 2015-11-24 17:27:24,547 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:27:24 INFO - 2015-11-24 17:27:24,547 DEBUG : BROWSER_OUTPUT: |0;Richards;176.14937466971992 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;161.18633139909736 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.12570781426956 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4735.8490566037735 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1727.1157167530225 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: |5;Earley;796.1783439490446 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: |6;Boyer;12500 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: |8;Splay;608.4592145015106 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4533.93665158371 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: __startTimestamp1448414844545__endTimestamp 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:27:24 INFO - 2015-11-24 17:27:24,548 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:176.15 Median:176.15 stddev:0.00 (0.0%) 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: Values: 176.1 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:161.19 Median:161.19 stddev:0.00 (0.0%) 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: Values: 161.2 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.13 Median:283.13 stddev:0.00 (0.0%) 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: Values: 283.1 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4735.85 Median:4735.85 stddev:0.00 (0.0%) 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: Values: 4735.8 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1727.12 Median:1727.12 stddev:0.00 (0.0%) 17:27:24 INFO - 2015-11-24 17:27:24,549 DEBUG : BROWSER_OUTPUT: Values: 1727.1 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: Values: 796.2 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: Values: 12500.0 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: Values: 27027.0 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.46 Median:608.46 stddev:0.00 (0.0%) 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: Values: 608.5 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: 17:27:24 INFO - 2015-11-24 17:27:24,550 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4533.94 Median:4533.94 stddev:0.00 (0.0%) 17:27:24 INFO - 2015-11-24 17:27:24,551 DEBUG : BROWSER_OUTPUT: Values: 4533.9 17:27:24 INFO - 2015-11-24 17:27:24,551 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:27:24 INFO - 2015-11-24 17:27:24,551 DEBUG : BROWSER_OUTPUT: 17:27:25 INFO - 2015-11-24 17:27:25,354 INFO : Browser exited with error code: 0 17:27:25 INFO - 2015-11-24 17:27:25,372 INFO : Completed test v8_7 (00:00:37) 17:27:25 INFO - 2015-11-24 17:27:25,555 INFO : Completed test suite (00:20:06) 17:27:25 INFO - 2015-11-24 17:27:25,556 DEBUG : Working with test: dromaeo_css 17:27:25 INFO - 2015-11-24 17:27:25,556 DEBUG : Generating results file: dromaeo_css 17:27:25 INFO - 2015-11-24 17:27:25,557 DEBUG : Working with test: kraken 17:27:25 INFO - 2015-11-24 17:27:25,557 DEBUG : Generating results file: kraken 17:27:25 INFO - 2015-11-24 17:27:25,557 INFO : javascript benchmark 17:27:25 INFO - 2015-11-24 17:27:25,557 DEBUG : Working with test: v8_7 17:27:25 INFO - 2015-11-24 17:27:25,557 DEBUG : Generating results file: v8_7 17:27:25 INFO - 2015-11-24 17:27:25,557 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:25 INFO - 2015-11-24 17:27:25,941 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 17:27:25 INFO - 2015-11-24 17:27:25,941 DEBUG : process_Request line: dromaeo_css 7773.03 graph.html#tests=[[72,64,59]] 17:27:25 INFO - 2015-11-24 17:27:25,941 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:25 INFO - 2015-11-24 17:27:25,967 DEBUG : process_Request line: kraken 1421.20 graph.html#tests=[[232,64,59]] 17:27:25 INFO - 2015-11-24 17:27:25,967 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:25 INFO - 2015-11-24 17:27:25,998 DEBUG : process_Request line: v8_7 20445.49 graph.html#tests=[[230,64,59]] 17:27:25 INFO - 2015-11-24 17:27:25,999 INFO : javascript benchmark 17:27:26 INFO - 2015-11-24 17:27:26,001 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3118.9532157017643, 3446.190145315852, 3459.42919418296, 3470.097774578609, 3522.682958533733, 5548.140038294061, 5704.600677952545, 5705.087186050233, 5762.135679648055, 5779.104238842976, 5736.684482353469, 5743.913841292374, 5751.993401154802, 5808.854778630536, 5916.142159386897, 5158.174692049282, 5173.249878767577, 5191.428942816287, 5229.346331708536, 5267.868303292429, 4799.808007679689, 5309.044372013036, 5334.226537152111, 5340.25236466895, 5341.732913354336, 5094.694318340893, 5189.610779191538, 5201.869953251199, 5216.634835561512, 5256.579473642099, 5004.824831130893, 5093.923591146136, 5108.770105345231, 5119.2321151827155, 5120.001599688062, 5135.152699804527, 5174.844754657329, 5193.221016847466, 5219.164933610642, 5225.477452254782, 5519.172124181365, 5694.117411801178, 5729.656220626775, 5762.827115186509, 5765.336986246593, 6066.5945044141135, 6176.135341052256, 6195.132681424604, 6203.627782333075, 6226.657533835637, 6212.0, 6235.781747638811, 6245.6252624842655, 6248.468880145193, 6252.499800016033, 5659.971700141473, 5933.139694744238, 5951.791687290924, 5954.583179177459, 5972.432618901197, 6143.938560614337, 6176.135341052256, 6216.720247588779, 6255.562110652301, 6267.4045965633195, 6166.907496387557, 6185.721642526097, 6204.441600255998, 6205.720742566596, 6226.968865155736, 6084.30030546484, 6209.59637623553, 6234.875302494015, 6242.843928901813, 6247.843803904939, 6104.26748790148, 6113.633182009094, 6156.107364432132, 6192.009278515416, 6203.751849925952, 6200.782972595937, 6212.47193988516, 6221.3778622138325, 6221.4089661482085, 6222.719977600928, 4835.129676658235, 4959.330490383824, 4973.2042873140845, 4976.776045077981, 5016.197408414636, 4356.934645980313, 4459.888502787457, 4470.530594287618, 4482.932756008662, 4519.502854685982, 5763.423657634203, 5804.738786754606, 5810.854728631733, 5822.767089316465, 5822.796202132905, 6076.605020673642, 6225.128482012522, 6256.0303153011355, 6272.780452684134, 6281.7173227203975, 4920.434150072716, 5735.8852822944145, 5745.425457454221, 5753.309602847685, 5847.883042339129, 5436.3476382834315, 5444.183372494158, 5444.646098003617, 5448.073827449343, 5475.4524547545725, 6111.478540206873, 6352.0, 6355.459785918156, 6357.0, 6362.109304697254, 6133.671320645623, 6191.690415479118, 6208.658523781055, 6245.937540624717, 6274.717637706223, 6312.116303717391, 6356.809295721136, 6367.0, 6380.330065343258, 6385.29761726219, 6141.815745527641, 6174.753009879554, 6185.165002724754, 6204.937950620617, 6236.594621349598, 6051.727672254847, 6069.635821850527, 6104.38956104386, 6186.907196392148, 6192.969035154795, 6153.3716696182555, 6177.907331390123, 6200.286966998853, 6203.069539569101, 6218.906716399348, 6208.751649933952, 6211.006239001738, 6212.440880320612, 6218.22272215973, 6228.283747369111, 5784.739686714192, 5968.373320801254, 5975.40245975399, 5978.432048955342, 5986.491148252273, 4990.80036798524, 6010.33886272501, 6060.090986352083, 6094.39056094387, 6104.542159337979, 5613.522850557748, 5749.195112684144, 5752.338481074563, 5754.6259493134485, 5996.0], "unit": "ms", "name": "dojo.html", "value": 5699.778637629098}, {"lowerIsBetter": false, "replicates": [535.5363868302758, 552.0174090119583, 580.5297708855828, 635.9125894720029, 650.1483057195074, 32980.34039319215, 33521.66478335216, 33530.49704254438, 33559.161020974454, 33582.49626255605, 44315.77842110793, 44679.77660111695, 44762.0, 44839.0, 44853.87865303361, 9776.90223097767, 9996.2502812289, 10007.799844003115, 10012.499375031255, 10017.549210285519, 8799.076097009818, 8970.86543701845, 8986.14631609996, 9780.510974451285, 9905.059019393146, 10198.388096714183, 12000.879991200063, 12095.21381110225, 12115.0, 12129.211601245936, 11950.880491195063, 11965.162438629299, 12019.63941081769, 12029.157958942878, 12091.395430228453, 8856.424332418437, 8977.192052715287, 8980.55097245135, 9790.853137202948, 11915.582954596548, 44591.77704111491, 44925.0, 44928.77535612334, 44935.77532112318, 45092.3236151458, 3224.5002024685978, 3343.264481813997, 3394.9830250848836, 3442.6901578858024, 3880.1269714314335, 29607.0, 29607.70392296071, 30495.54256686129, 30605.0, 30642.0, 2811.5360965440677, 2818.309514169042, 2849.9430011399863, 2892.855357232151, 2958.0, 495994.52002739755, 498250.0, 498303.9999999964, 498964.0, 499043.0, 69027.0, 69589.0, 69628.99999999898, 69865.65067174734, 69895.0, 73136.63431682807, 73296.26703732894, 73571.63214183894, 73615.63192184005, 73616.0, 16943.0, 17421.47735567935, 17429.738553921703, 17449.825501745076, 17463.301467941394, 13138.934305328412, 13165.407556659973, 13205.603831885059, 13218.074734768667, 13238.53665121716, 20936.848473334114, 21258.0, 21385.78614213838, 21387.823669698315, 21450.892745536174, 8292.502449853027, 8483.109273526314, 8483.74548763538, 8497.915020849712, 8513.531755753493, 958.4488918871676, 970.4807927758616, 977.8484334928097, 980.3578655980344, 1005.0251256281396, 28726.0, 29766.0, 29950.95171668981, 30251.243718907204, 30470.667633164107, 954.6706386296717, 1085.0776839686202, 1094.2559059839386, 1186.3890096600257, 1209.3311230502027, 13940.930295348458, 14625.561233163022, 14793.778093328609, 15073.623159421102, 15110.697786044218, 438313.6168638337, 493999.0, 496462.0, 506984.0, 557836.0, 50206.49793502018, 61700.382996169465, 62168.689156553926, 62182.75634487376, 62230.75538489205, 1377.1392879450343, 1407.4510940733123, 1407.73956817989, 1452.3464441001802, 1454.120257244373, 23220.41948951222, 23807.809609519107, 28819.991300304388, 29615.25961850971, 30712.385752285278, 55471.44528554663, 55569.0, 55620.72189639188, 55661.16508252299, 55664.0, 399596.0, 401826.0, 402047.0, 402414.0, 404468.0, 30104.397912042074, 31286.0, 31400.685993139778, 31405.685943140277, 31508.842455787573, 45982.08035839198, 46127.76936115298, 46171.538284618066, 46572.53427465682, 47655.76172119117, 37753.0, 37981.62018379781, 38812.41781373338, 39161.804190978866, 39830.60169398385, 31707.682923171396, 36124.27751445009, 36658.8167059163, 36717.89846304615, 36916.63083369132, 36677.63322366742, 36945.07637309089, 36961.0, 37767.81116094402, 38838.6116138835, 26576.601350980138, 31156.0, 32839.0, 32871.67128328686, 32872.50691239681, 24783.87608061948, 24865.0, 24916.501669966863, 25235.62146567766, 25333.0], "unit": "ms", "name": "ext.html", "value": 20276.650920333435}, {"lowerIsBetter": false, "replicates": [363.4675200830784, 368.1201927393529, 369.77628534736465, 370.8090333478259, 371.867986864663, 16080.251385065776, 18250.0, 19534.90232548837, 20782.376528704142, 21040.158393664253, 21397.93010349484, 21570.460738481546, 21582.13671453144, 21598.3520494385, 21615.783842161614, 4782.952170478303, 6637.0, 6838.9658051709675, 6839.726410943581, 6849.280825513324, 4867.586255168315, 4897.951020489803, 7627.008488896464, 7678.500897441649, 7692.499987500794, 6474.482041436674, 7441.330280274774, 7465.888011679829, 7588.127365352972, 7632.809179770522, 6325.399087086719, 7447.515911465792, 7608.429367797437, 7622.847543049135, 7623.809404764897, 7257.274272572753, 7271.854562908712, 7278.308560686726, 7281.235470275651, 7373.373263272628, 23964.442311249713, 24946.50106997868, 26961.191164264907, 27070.0, 27895.860520697468, 2047.396018174642, 2176.923807666724, 2488.9004439822384, 2719.601590842177, 2850.900218492343, 15537.14545699986, 15652.373905043785, 15692.0, 15696.90121691482, 16365.918170409192, 1780.7506949027147, 1831.9450416487393, 1860.0792607659296, 1898.0549634780134, 1917.1851962915705, 88218.0, 94283.11433771354, 103797.0, 106008.99999999923, 110314.44842775735, 14853.554393368217, 18366.54083647893, 18861.24555017784, 18957.43127706171, 19014.239430422906, 27791.722082779317, 27856.442871142463, 27872.0, 27930.02244921418, 27935.58096628552, 8060.476069055492, 8292.37807164465, 8302.418830681914, 8373.41386102979, 10506.947465262625, 8446.408751387344, 8447.36644751646, 8451.408401411842, 8462.19609137131, 8533.829323413496, 4048.919021619551, 4156.709030367906, 4163.375493675912, 4287.914241715148, 4305.277888844487, 1773.8492228160492, 1819.8908065516111, 1825.497988053296, 1827.168638269584, 1829.6798060339388, 897.1725171445296, 910.9590068446936, 972.7665360313474, 981.8068220698261, 1087.217203613397, 17915.73126403079, 19737.802621973882, 21046.579068418545, 21515.0, 21520.246791362228, 939.178219058324, 952.9237660987104, 979.2557656181211, 1010.6715317521688, 1030.443560477349, 9209.631614735335, 11110.0, 11157.442127893573, 11160.274582152297, 11162.330260184415, 671023.0, 719598.0, 731698.0, 760577.0, 764737.0, 112755.0, 115565.8443415572, 116182.0, 117225.4138729318, 120185.0, 1112.7162573543694, 1127.3912087472836, 1129.836173754801, 1140.361397617337, 1164.67971307891, 18361.54096147607, 18408.539786505444, 18628.068596569847, 18666.346677866208, 18715.719264210777, 47153.52846471492, 49803.0, 50263.74868125636, 50265.74867125641, 50678.0, 61446.54213831397, 67673.0, 70526.29473705402, 70935.93596096167, 74859.25140748522, 9318.161365477139, 9652.227821774382, 9897.50512474359, 9979.251556133464, 9981.251406144424, 11607.6517704469, 19336.613267734287, 19383.903080484506, 19521.51196220049, 20183.09176087109, 15485.84514154844, 15598.454054108051, 15707.214639267762, 16016.599585010468, 16140.435084771976, 15441.5367538974, 15480.922595386952, 15587.0, 15765.605859853595, 15772.0, 12496.812547811973, 16648.0, 16967.830321697118, 17279.481615551555, 17287.481375558753, 9902.504874756089, 9958.452285124387, 9995.67566492867, 10013.599456021677, 10136.391816491034, 10390.740231494274, 11542.877682039118, 16114.194290285204, 16453.753193702345, 16582.419615313407], "unit": "ms", "name": "jquery.html", "value": 10819.215320890009}, {"lowerIsBetter": false, "replicates": [1600.2398860541243, 1600.9759853602197, 1714.6656402001615, 1901.5341241395856, 1941.5340318323601, 7724.497907636007, 7947.562884041383, 8104.513729176246, 8227.588620568977, 8246.670133194664, 8351.582420878962, 8466.238038576526, 8499.0, 8504.532250726208, 8513.91486085139, 2111.324376199617, 2168.176093084626, 2357.0453966143696, 2383.2254517281867, 2385.8329916905823, 2068.751749790027, 2177.052981952848, 2365.5150694107665, 2365.515069410775, 2394.6767186429784, 2330.498942727313, 2350.7296660883962, 2365.9408514787096, 2379.940501487459, 2382.7855493005627, 2127.723395958531, 2159.708439360682, 2172.1854304635763, 2327.8836058197107, 2365.124903785602, 2332.125452955142, 2384.5350156719446, 2387.271882075966, 2387.9761202387926, 2391.1033362489065, 8242.340612750966, 8436.789080273042, 8445.113263107347, 8448.155184481564, 8455.577221138918, 5103.081445339837, 5185.585153187736, 5196.29849970253, 5225.294585230983, 5234.398044224887, 3466.480027995796, 3514.0, 3604.6034936157002, 3607.2244467439364, 3608.9458658120147, 1051.1905832508926, 1053.3100818963592, 1064.3986147826454, 1067.3755852826107, 1081.9883409012598, 11170.553177872875, 11232.831507527393, 11234.719132021764, 11235.157363197794, 11268.549258029669, 4601.309803529431, 4686.484486706459, 4724.4094488188975, 4755.096531658974, 4770.212914869007, 9697.369670971364, 9701.126898579161, 9702.078302561245, 9708.271879609058, 9719.271054670928, 5244.213367994831, 5248.475152484797, 5251.2123181523075, 5265.210218467184, 5265.947340526623, 4755.83354582588, 4793.23308270675, 4794.760261986887, 4800.1119792837735, 4810.518948105231, 3012.4426981008583, 3728.7762734236035, 3738.6074462181623, 3768.7550309229814, 3868.4777555030273, 1003.9598416063276, 1046.6179844356755, 1110.7667389848061, 1140.863096428434, 1175.9529618815322, 1113.0983903038564, 1122.8708698499613, 1123.4438952718456, 1131.9490622921987, 1351.803988421693, 7966.880496792553, 7983.680652773824, 8058.798530036796, 8062.395320350997, 8169.223923727236, 1213.7848426621451, 1223.113242898909, 1234.1792707849359, 1274.8533918599294, 1276.5595869425033, 4546.886327841764, 6021.217241758631, 6052.606580572248, 6138.7237574309265, 6155.138280640714, 10018.749531261778, 10063.295569310078, 10234.48827558619, 10327.431991240404, 10327.896721032694, 10143.594256229668, 10221.897781022244, 10234.181265498743, 10250.38497690141, 10263.973602639677, 7870.488418252795, 7930.246626570467, 7957.442978991531, 8047.637856296364, 8078.757637270891, 7915.84168316642, 7967.282944534788, 7968.442209045543, 7980.960095199487, 8005.719799806979, 8979.820403592023, 9009.684661036832, 9195.586198620944, 9300.953495232481, 9305.348625596414, 8533.573321334032, 9368.297377696565, 9390.530473476436, 9403.858942115738, 9475.763105922408, 6910.412614927787, 6983.1620205575655, 7004.579725216503, 7006.019157318082, 7011.123609548807, 7655.196204398458, 7957.7612671619945, 8047.356211503183, 8052.557109358807, 8054.23484768946, 7421.554706717398, 7456.403487721078, 7461.738839140604, 7532.8493430132185, 7644.0827100748265, 7171.677274522764, 7282.781516554512, 7353.8161545961775, 7484.0, 7507.286807753255, 7408.925296002099, 7415.961765352747, 7421.2949769771785, 7428.517146385468, 7465.552066876005, 6803.183617965876, 6931.202911665223, 6953.965230173817, 6957.478189135733, 6961.860762784615, 6353.904691429725, 7020.684069216795, 7065.788026359218, 7068.045813815069, 7070.116235470567], "unit": "ms", "name": "mootools.html", "value": 4772.56526037097}, {"lowerIsBetter": false, "replicates": [322.2732737676539, 329.91752061984505, 330.58181400528326, 337.54431517451445, 341.9504171895074, 6669.866602667944, 6806.0, 6806.3193680631975, 6820.181578210615, 6835.0, 6784.864302713942, 6811.046453496502, 6812.863742725155, 6830.692618832152, 6831.453483721303, 4871.780769865364, 4997.350344455216, 5008.724520151409, 5012.799488020475, 5048.798048078091, 4877.02459508098, 4956.330895329139, 5014.473480284572, 5014.648974571782, 5017.996400719852, 4052.5542190359038, 4972.353594032788, 4984.202527595586, 5014.022265658198, 5015.899682006358, 3801.3917773156163, 4959.429665588467, 4967.006598680278, 4967.528084831935, 4982.128127577677, 4263.91472170558, 4264.829406823724, 4269.082147338306, 4272.03879127197, 4273.059926816096, 6279.309275979638, 6538.313477084886, 6544.869102617969, 6551.574147680433, 6554.213494380705, 5874.618149820248, 5911.940880591225, 5914.319853216892, 5921.200637913869, 5927.9703601481715, 6919.8962015569805, 7181.569105853613, 7295.854082918365, 7302.1967583565765, 7328.0, 3923.038855480397, 4656.115338085753, 4717.716936983792, 4832.685875418122, 4833.419989601235, 7728.420368472387, 7768.57272849993, 7785.90997260384, 7809.531428114331, 7823.374130069581, 3993.7603743775467, 4592.747398893026, 4896.681715688469, 4907.582855457326, 4917.0903382874285, 4804.327394164819, 4813.95186048142, 4816.446108697474, 4816.8554943351055, 4831.685940413862, 4727.0, 5917.260342457193, 5917.940820591739, 5924.259467566554, 5928.466438020512, 5685.658860468385, 7393.038904942323, 7399.223081576357, 7417.851642967111, 7419.369353604896, 1632.3225861267679, 1674.6566953774447, 1678.6139187986832, 1684.9241784119745, 1686.6542358816414, 899.3884158771967, 902.891653001644, 1057.645688694296, 1082.118073769875, 1087.4780105549223, 6750.223724271674, 6775.085363475966, 6796.422304104207, 6798.184217893884, 6821.147356580427, 6091.482224011009, 6224.692814509004, 7617.466777325645, 7627.618619069135, 7644.503107298008, 6189.876202475925, 6553.57401768893, 6603.0, 6773.390394864387, 6868.416184624263, 2924.736773690378, 3154.9588635750147, 4033.878983630496, 4035.455213546192, 4050.25070361984, 7532.209118042636, 7887.526748395115, 7905.762827115196, 7910.920890791133, 7939.483933544417, 6351.587146835441, 7740.690372385042, 7857.646405911633, 7894.842103157905, 8050.31572316348, 7698.653560589675, 8020.157883422274, 8037.919620803717, 8042.115367309591, 8051.154628763896, 7521.661525231269, 7626.521380551232, 7627.733029343946, 7633.160352361125, 7638.694452222071, 7595.392368610608, 7617.466777325534, 7630.694772209272, 7631.1605723369275, 7631.771046868603, 7790.026246719161, 8004.0, 8021.27808497238, 8025.638846251816, 8029.357651387758, 4748.240281554935, 4777.474477807369, 4807.975960120177, 4808.182608956416, 4810.39870016248, 7689.077310722525, 7694.846103078019, 7695.923040769745, 7696.461247712607, 7696.8075798103255, 7141.892871607034, 7413.703451861865, 7416.480846340704, 7424.406047516294, 7426.071741032371, 7383.114026316662, 7386.446016548888, 7394.408447324308, 7398.482106252511, 7402.555846649003, 6975.895361569479, 7214.206437291999, 7221.4222862169845, 7230.74692385764, 7237.819054523468, 7424.740134095497, 7426.962865185639, 7430.0, 7443.404527637667, 7450.92549074524, 7224.963875180591, 7240.312170343809, 7241.0, 7244.891326630211, 7253.274672532915], "unit": "ms", "name": "prototype.html", "value": 5287.037809973683}, {"lowerIsBetter": false, "replicates": [739.5525706947296, 807.1041144329793, 807.7940125268055, 822.1901427094311, 826.9627866745996, 15387.153706546136, 15455.45905893294, 15492.380304787823, 15501.302441390137, 15507.534773956786, 14155.0, 14255.429782808675, 14294.857051429482, 14310.926680498953, 14314.498992535264, 770.299027884625, 781.9687212511493, 782.6947490478718, 950.0, 981.8429051351785, 961.125375907924, 961.4759955824057, 974.5663179884954, 974.9220062395027, 979.5787811241163, 1005.2008653120787, 1026.2251999740186, 1028.804527139841, 1030.6856408795315, 1031.0102301790291, 798.8362385710944, 815.8980127484065, 1004.9799004019915, 1011.701548043329, 1029.6756521695643, 757.8825282081286, 765.7013764631798, 768.0744702633314, 768.7117331000875, 769.3268390158611, 12237.816432753516, 14559.272036398137, 14660.340284687214, 14805.481808136663, 14817.0, 12383.876161238362, 12957.09300348976, 12982.415791289415, 13126.85980434115, 13322.86677133226, 10247.538860751283, 10288.537015834305, 10309.329893556895, 10321.535530901128, 10352.327098738633, 3552.928941421157, 3597.6042635310355, 3603.045193023851, 3603.8017909015257, 3605.8737944171826, 80075.5996220021, 80483.5975820123, 81002.59498702468, 81882.59058704728, 82089.17910820874, 9729.221662267002, 9787.265955053399, 9951.80096398068, 9969.55137018836, 10453.21600879937, 21380.0, 21605.891970540048, 21624.0, 21642.35072947814, 21668.4582885426, 7004.229534751174, 7165.140183177948, 7188.820279493055, 7274.1634712007735, 7354.043974283309, 3935.2326296371934, 3998.4002399639703, 4002.2995975704134, 4005.3991901214467, 4015.658669013108, 3535.0, 3575.982120089435, 3576.8211589420425, 3587.874424395186, 3587.892363229107, 647.5531883000715, 653.8136631060125, 662.8309781005813, 664.5447868210291, 665.6139439125295, 454.86808825440914, 481.1795888010933, 493.4399456616766, 516.9508896654812, 529.4520171622353, 7995.617202480242, 8667.0, 8741.388102832869, 8881.911180888237, 9044.457332560067, 570.7374607680431, 577.0910815465659, 581.3169525807244, 591.5888457522067, 627.3882964109956, 4024.557298697141, 4053.0272734544087, 4205.936910946339, 4322.524522302544, 4502.482214545304, 82587.58706206431, 83263.0, 84114.15885841186, 88285.11714882769, 88318.55840720884, 75381.62309188419, 76364.85452718213, 77088.22911770923, 77784.0, 78796.42407151825, 67592.0, 67802.66098669475, 68343.0, 68528.31471685319, 69735.65132174306, 8964.68623598171, 8972.641094356153, 8972.68595599177, 8980.281577473917, 9072.637094516145, 48771.75614121907, 48938.77653058702, 49033.75483122562, 49081.50918490912, 49791.00417991693, 63354.68322658357, 67342.0, 69355.0, 70260.59478810293, 70631.0, 10752.677419677422, 10964.0, 10973.890261097287, 11173.441327933408, 11377.2604780689, 11424.942875285571, 11711.590094346657, 12151.088668350087, 12431.564895228623, 12480.251184928933, 11178.653349781323, 11473.885261147281, 11789.174757767218, 11839.763204735686, 12293.737143423557, 10990.340579565252, 11487.310761354345, 11743.647690569296, 12276.017918566671, 12282.692932676397, 10875.40185289785, 11406.0, 11517.193796434169, 11559.595414160463, 12093.818592721293, 9433.952830235805, 9697.224222062077, 9753.366031207948, 9762.658306959222, 10227.386356818615, 9270.304727145356, 9338.85279670408, 9994.350367226398, 10013.649522266685, 10035.197184225099], "unit": "ms", "name": "yui.html", "value": 6990.20566331947}], "name": "dromaeo_css", "value": 7773.029832795199}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [102.0, 112.0, 115.0, 155.0, 128.0, 109.0, 111.0, 109.0, 109.0, 118.0], "unit": "ms", "name": "ai-astar", "value": 116.8}, {"lowerIsBetter": true, "replicates": [147.0, 120.0, 142.0, 157.0, 118.0, 139.0, 147.0, 144.0, 165.0, 119.0], "unit": "ms", "name": "audio-beat-detection", "value": 139.8}, {"lowerIsBetter": true, "replicates": [186.0, 219.0, 180.0, 186.0, 184.0, 183.0, 182.0, 185.0, 184.0, 183.0], "unit": "ms", "name": "audio-dft", "value": 187.2}, {"lowerIsBetter": true, "replicates": [60.0, 70.0, 76.0, 73.0, 56.0, 61.0, 82.0, 101.0, 102.0, 54.0], "unit": "ms", "name": "audio-fft", "value": 73.5}, {"lowerIsBetter": true, "replicates": [86.0, 82.0, 117.0, 75.0, 77.0, 75.0, 113.0, 77.0, 74.0, 112.0], "unit": "ms", "name": "audio-oscillator", "value": 88.8}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 87.0, 85.0, 85.0, 130.0, 132.0, 87.0, 85.0, 90.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 95.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.1}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 87.0, 85.0, 83.0, 84.0, 86.0, 84.0, 85.0, 86.0], "unit": "ms", "name": "imaging-desaturate", "value": 85.3}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 63.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 66.0, 66.0, 69.0, 68.0, 68.0, 69.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 81.0, 81.0, 81.0, 80.0, 79.0, 87.0, 106.0, 107.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [121.0, 123.0, 128.0, 121.0, 122.0, 120.0, 124.0, 120.0, 118.0, 123.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [134.0, 147.0, 138.0, 134.0, 137.0, 124.0, 137.0, 136.0, 138.0, 125.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 76.0, 75.0, 95.0, 54.0, 88.0, 89.0, 94.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 76.3}], "name": "kraken", "value": 1421.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [176.14937466971992], "unit": "score", "name": "Richards", "value": 200.40945399999995}, {"lowerIsBetter": false, "replicates": [161.18633139909736], "unit": "score", "name": "DeltaBlue", "value": 410.196072}, {"lowerIsBetter": false, "replicates": [283.12570781426956], "unit": "score", "name": "Encrypt", "value": 940.1512919999999}, {"lowerIsBetter": false, "replicates": [4735.8490566037735], "unit": "score", "name": "Decrypt", "value": 56.20554980079682}, {"lowerIsBetter": false, "replicates": [1727.1157167530225], "unit": "score", "name": "RayTrace", "value": 428.4536310000001}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [608.4592145015106], "unit": "score", "name": "Splay", "value": 133.93009433962266}, {"lowerIsBetter": false, "replicates": [4533.93665158371], "unit": "score", "name": "NavierStokes", "value": 327.3093812375252}], "name": "v8_7", "value": 20445.490942695666}]} 17:27:26 INFO - RETURN: dromaeo_css: 7773.03 17:27:26 INFO - RETURN: kraken: 1421.20 17:27:26 INFO - RETURN: v8_7: 20445.49 17:27:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20445.49"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1421.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7773.03"}}} 17:27:26 INFO - Return code: 0 17:27:26 INFO - # TBPL SUCCESS # 17:27:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:27:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:27:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:27:26 INFO - 2015-11-24 17:27:26.119 screenresolution[2176:14980] starting screenresolution argv=screenresolution get 17:27:26 INFO - 2015-11-24 17:27:26.121 screenresolution[2176:14980] Display 0: 1600x1200x32@60 17:27:26 INFO - 2015-11-24 17:27:26.127 screenresolution[2177:14983] starting screenresolution argv=screenresolution list 17:27:26 INFO - Available Modes on Display 0 17:27:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:27:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:27:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:27:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:27:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:27:26 INFO - Intel Iris: 17:27:26 INFO - Chipset Model: Intel Iris 17:27:26 INFO - Type: GPU 17:27:26 INFO - Bus: Built-In 17:27:26 INFO - VRAM (Dynamic, Max): 1536 MB 17:27:26 INFO - Vendor: Intel (0x8086) 17:27:26 INFO - Device ID: 0x0a2e 17:27:26 INFO - Revision ID: 0x0009 17:27:26 INFO - Displays: 17:27:26 INFO - Display: 17:27:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:27:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:27:26 INFO - Display Serial Number: 1600x1200 60 17:27:26 INFO - Main Display: Yes 17:27:26 INFO - Mirror: Off 17:27:26 INFO - Online: Yes 17:27:26 INFO - Rotation: Supported 17:27:26 INFO - Return code: 0 17:27:26 INFO - Running post-action listener: _resource_record_post_action 17:27:26 INFO - Running post-run listener: _resource_record_post_run 17:27:27 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 2748416; Write bytes: 693809152; Read time: 42; Write time: 2244 17:27:27 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334641664; Write bytes: 337233408; Read time: 26101; Write time: 629 17:27:27 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 2748416; Write bytes: 345905664; Read time: 42; Write time: 1586 17:27:27 INFO - Running post-run listener: _upload_blobber_files 17:27:27 INFO - Blob upload gear active. 17:27:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:27:27 INFO - Copying logs to upload dir... 17:27:27 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1341.718781 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 21 secs) (at 2015-11-24 17:27:27.475673) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 17:27:27.478712) ========= 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.S0DkR0dOK1/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.bi58UaoQn9/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009638 build_url: 'https://queue.taskcluster.net/v1/task/dc76W9gASI2FWkPUYzY5kQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 17:27:27.501798) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 17:27:27.502142) ========= 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.S0DkR0dOK1/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.bi58UaoQn9/Listeners TMPDIR=/var/folders/nt/6n4mpcwd6b505zxjmcffgz5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004598 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 17:27:27.550125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 17:27:27.550439) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 17:27:27.550794) ========= ========= Total master_lag: 0.22 =========