builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0104 starttime: 1447481304.46 results: success (0) buildid: 20151113211931 builduid: 4cb3b8905da04c46bad99c3fc3b8ec0e revision: 81de57cbfed15c61062f2292cef14caf9c21d989 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:24.463491) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:24.464423) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:24.464788) ========= 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.erwtkdXTIv/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.UVUh7qSFdo/Listeners TMPDIR=/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006098 basedir: '/builds/slave/test' ========= master_lag: 0.41 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:24.884750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:24.885127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:24.970688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:24.971094) ========= 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.erwtkdXTIv/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.UVUh7qSFdo/Listeners TMPDIR=/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.013373 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.044335) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.044770) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.045273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.045642) ========= 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.erwtkdXTIv/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.UVUh7qSFdo/Listeners TMPDIR=/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-13 22:08:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-13 22:08:25 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179342 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.242723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.243228) ========= 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.erwtkdXTIv/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.UVUh7qSFdo/Listeners TMPDIR=/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.139050 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.400908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.401374) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 81de57cbfed15c61062f2292cef14caf9c21d989 --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 81de57cbfed15c61062f2292cef14caf9c21d989 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.erwtkdXTIv/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.UVUh7qSFdo/Listeners TMPDIR=/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-13 22:08:25,500 truncating revision to first 12 chars 2015-11-13 22:08:25,500 Setting DEBUG logging. 2015-11-13 22:08:25,500 attempt 1/10 2015-11-13 22:08:25,501 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/81de57cbfed1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 22:08:25,752 unpacking tar archive at: fx-team-81de57cbfed1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.950476) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.950840) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.965145) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.965522) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 22:08:25.966028) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2015-11-13 22:08:25.966421) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.erwtkdXTIv/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.UVUh7qSFdo/Listeners TMPDIR=/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 22:08:26 INFO - MultiFileLogger online at 20151113 22:08:26 in /builds/slave/test 22:08:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:08:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:08:26 INFO - {'append_to_log': False, 22:08:26 INFO - 'base_work_dir': '/builds/slave/test', 22:08:26 INFO - 'blob_upload_branch': 'Fx-Team', 22:08:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:08:26 INFO - 'branch': 'Fx-Team', 22:08:26 INFO - 'buildbot_json_path': 'buildprops.json', 22:08:26 INFO - 'config_files': ('talos/mac_config.py',), 22:08:26 INFO - 'default_actions': ('clobber', 22:08:26 INFO - 'read-buildbot-config', 22:08:26 INFO - 'download-and-extract', 22:08:26 INFO - 'populate-webroot', 22:08:26 INFO - 'create-virtualenv', 22:08:26 INFO - 'install', 22:08:26 INFO - 'run-tests'), 22:08:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:08:26 INFO - 'download_minidump_stackwalk': True, 22:08:26 INFO - 'download_symbols': 'ondemand', 22:08:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:08:26 INFO - 'tooltool.py': '/tools/tooltool.py', 22:08:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:08:26 INFO - '/tools/misc-python/virtualenv.py')}, 22:08:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:08:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:08:26 INFO - 'installer_path': 'installer.exe', 22:08:26 INFO - 'log_level': 'info', 22:08:26 INFO - 'log_name': 'talos', 22:08:26 INFO - 'log_to_console': True, 22:08:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:08:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:08:26 INFO - 'opt_config_files': (), 22:08:26 INFO - 'pip_index': False, 22:08:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:08:26 INFO - 'cmd': ('bash', 22:08:26 INFO - '-c', 22:08:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:08:26 INFO - 'enabled': True, 22:08:26 INFO - 'halt_on_failure': False, 22:08:26 INFO - 'name': 'check_screen_resolution'},), 22:08:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:08:26 INFO - 'cmd': ('bash', 22:08:26 INFO - '-c', 22:08:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:08:26 INFO - 'enabled': True, 22:08:26 INFO - 'halt_on_failure': False, 22:08:26 INFO - 'name': 'check_screen_resolution'},), 22:08:26 INFO - 'run_cmd_checks_enabled': True, 22:08:26 INFO - 'sps_profile': False, 22:08:26 INFO - 'sps_profile_interval': 0, 22:08:26 INFO - 'suite': 'dromaeojs-e10s', 22:08:26 INFO - 'system_bits': '64', 22:08:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:08:26 INFO - 'title': 't-yosemite-r5-0104', 22:08:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:08:26 INFO - 'use_talos_json': True, 22:08:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:08:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:08:26 INFO - 'work_dir': 'build'} 22:08:26 INFO - ##### 22:08:26 INFO - ##### Running clobber step. 22:08:26 INFO - ##### 22:08:26 INFO - Running pre-action listener: _resource_record_pre_action 22:08:26 INFO - Running main action method: clobber 22:08:26 INFO - rmtree: /builds/slave/test/build 22:08:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:08:29 INFO - Running post-action listener: _resource_record_post_action 22:08:29 INFO - ##### 22:08:29 INFO - ##### Running read-buildbot-config step. 22:08:29 INFO - ##### 22:08:29 INFO - Running pre-action listener: _resource_record_pre_action 22:08:29 INFO - Running main action method: read_buildbot_config 22:08:29 INFO - Using buildbot properties: 22:08:29 INFO - { 22:08:29 INFO - "properties": { 22:08:29 INFO - "buildnumber": 40, 22:08:29 INFO - "product": "firefox", 22:08:29 INFO - "script_repo_revision": "production", 22:08:29 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 22:08:29 INFO - "repository": "", 22:08:29 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 22:08:29 INFO - "buildid": "20151113211931", 22:08:29 INFO - "slavename": "t-yosemite-r5-0104", 22:08:29 INFO - "pgo_build": "False", 22:08:29 INFO - "basedir": "/builds/slave/test", 22:08:29 INFO - "project": "", 22:08:29 INFO - "platform": "yosemite", 22:08:29 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:08:29 INFO - "slavebuilddir": "test", 22:08:29 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:08:29 INFO - "branch": "fx-team", 22:08:29 INFO - "repo_path": "integration/fx-team", 22:08:29 INFO - "stage_platform": "macosx64", 22:08:29 INFO - "builduid": "4cb3b8905da04c46bad99c3fc3b8ec0e", 22:08:29 INFO - "revision": "81de57cbfed15c61062f2292cef14caf9c21d989" 22:08:29 INFO - }, 22:08:29 INFO - "sourcestamp": { 22:08:29 INFO - "repository": "", 22:08:29 INFO - "hasPatch": false, 22:08:29 INFO - "project": "", 22:08:29 INFO - "branch": "fx-team-macosx64-talos", 22:08:29 INFO - "changes": [ 22:08:29 INFO - { 22:08:29 INFO - "category": null, 22:08:29 INFO - "files": [ 22:08:29 INFO - { 22:08:29 INFO - "url": null, 22:08:29 INFO - "name": "https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 22:08:29 INFO - } 22:08:29 INFO - ], 22:08:29 INFO - "repository": "", 22:08:29 INFO - "rev": "81de57cbfed15c61062f2292cef14caf9c21d989", 22:08:29 INFO - "who": "philringnalda@gmail.com", 22:08:29 INFO - "when": 1447481276, 22:08:29 INFO - "number": 6661710, 22:08:29 INFO - "comments": "Merge m-c to f-t", 22:08:29 INFO - "project": "", 22:08:29 INFO - "at": "Fri 13 Nov 2015 22:07:56", 22:08:29 INFO - "branch": "fx-team-macosx64-talos", 22:08:29 INFO - "revlink": "", 22:08:29 INFO - "properties": [ 22:08:29 INFO - [ 22:08:29 INFO - "buildid", 22:08:29 INFO - "20151113211931", 22:08:29 INFO - "Change" 22:08:29 INFO - ], 22:08:29 INFO - [ 22:08:29 INFO - "builduid", 22:08:29 INFO - "4cb3b8905da04c46bad99c3fc3b8ec0e", 22:08:29 INFO - "Change" 22:08:29 INFO - ], 22:08:29 INFO - [ 22:08:29 INFO - "pgo_build", 22:08:29 INFO - "False", 22:08:29 INFO - "Change" 22:08:29 INFO - ] 22:08:29 INFO - ], 22:08:29 INFO - "revision": "81de57cbfed15c61062f2292cef14caf9c21d989" 22:08:29 INFO - } 22:08:29 INFO - ], 22:08:29 INFO - "revision": "81de57cbfed15c61062f2292cef14caf9c21d989" 22:08:29 INFO - } 22:08:29 INFO - } 22:08:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 22:08:29 INFO - Running post-action listener: _resource_record_post_action 22:08:29 INFO - ##### 22:08:29 INFO - ##### Running download-and-extract step. 22:08:29 INFO - ##### 22:08:29 INFO - Running pre-action listener: _resource_record_pre_action 22:08:29 INFO - Running main action method: download_and_extract 22:08:29 INFO - mkdir: /builds/slave/test/build/tests 22:08: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')]} 22:08:29 INFO - https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:08:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/test_packages.json 22:08:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/test_packages.json 22:08:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:08:33 INFO - Downloaded 1149 bytes. 22:08:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:08:33 INFO - Using the following test package requirements: 22:08:33 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:08:33 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:08:33 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 22:08:33 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:08:33 INFO - u'jsshell-mac.zip'], 22:08:33 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:08:33 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 22:08:33 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:08:33 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:08:33 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 22:08:33 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:08:33 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 22:08:33 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:08:33 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 22:08:33 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:08:33 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:08:33 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 22:08:33 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:08:33 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')]} 22:08:33 INFO - https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:08:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:08:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:08:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/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 22:08:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/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 22:08:34 INFO - Downloaded 17460985 bytes. 22:08:34 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 22:08:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:08:34 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:08:39 INFO - Return code: 0 22:08:39 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 22:08:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:39 INFO - https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:08:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:08:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:08:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/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 22:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/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 22:08:41 INFO - Downloaded 17460985 bytes. 22:08:41 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 22:08:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:08:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:08:47 INFO - Return code: 0 22:08:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:47 INFO - https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:08:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:08:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:08:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/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 22:08:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/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 22:08:48 INFO - Downloaded 11131693 bytes. 22:08:48 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 22:08:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:08:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 22:08:49 INFO - Return code: 0 22:08:49 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')]} 22:08:49 INFO - https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 22:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hyVTX4usQ8yAmNRFqLrK2A/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 22:08:57 INFO - Downloaded 108701625 bytes. 22:08:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:08:57 INFO - mkdir: /builds/slave/test/properties 22:08:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:08:57 INFO - Writing to file /builds/slave/test/properties/build_url 22:08:57 INFO - Contents: 22:08:57 INFO - build_url:https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:08:57 INFO - Running post-action listener: _resource_record_post_action 22:08:57 INFO - Running post-action listener: set_extra_try_arguments 22:08:57 INFO - ##### 22:08:57 INFO - ##### Running populate-webroot step. 22:08:57 INFO - ##### 22:08:57 INFO - Running pre-action listener: _resource_record_pre_action 22:08:57 INFO - Running main action method: populate_webroot 22:08:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:08:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:08:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:08:57 INFO - '../fennec_ids.txt'], 22:08:57 INFO - 'tests': ['tcheck2']}, 22:08:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:08:57 INFO - '--tppagecycles', 22:08:57 INFO - '7'], 22:08:57 INFO - 'tests': ['tsvgm']}}, 22:08:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:08:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:08:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:08:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:08:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:08:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:08:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:08:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:08:57 INFO - 'talos_options': ['--e10s'], 22:08:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:08:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:08:57 INFO - 'tests': ['damp', 'tps']}, 22:08:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:08:57 INFO - 'talos_options': ['--e10s'], 22:08:57 INFO - 'tests': ['damp', 'tps']}, 22:08:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:08:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:08:57 INFO - 'other': {'tests': ['a11yr', 22:08:57 INFO - 'ts_paint', 22:08:57 INFO - 'tpaint', 22:08:57 INFO - 'sessionrestore', 22:08:57 INFO - 'sessionrestore_no_auto_restore']}, 22:08:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:08:57 INFO - 'tests': ['a11yr', 22:08:57 INFO - 'ts_paint', 22:08:57 INFO - 'tpaint', 22:08:57 INFO - 'sessionrestore', 22:08:57 INFO - 'sessionrestore_no_auto_restore']}, 22:08:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:08:57 INFO - 'tests': ['a11yr', 22:08:57 INFO - 'ts_paint', 22:08:57 INFO - 'tpaint', 22:08:57 INFO - 'sessionrestore', 22:08:57 INFO - 'sessionrestore_no_auto_restore']}, 22:08:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:08:57 INFO - 'tests': ['a11yr', 22:08:57 INFO - 'ts_paint', 22:08:57 INFO - 'tpaint', 22:08:57 INFO - 'sessionrestore', 22:08:57 INFO - 'sessionrestore_no_auto_restore']}, 22:08:57 INFO - 'other_l64': {'tests': ['a11yr', 22:08:57 INFO - 'ts_paint', 22:08:57 INFO - 'tpaint', 22:08:57 INFO - 'sessionrestore', 22:08:57 INFO - 'sessionrestore_no_auto_restore']}, 22:08:57 INFO - 'other_nol64': {'tests': ['a11yr', 22:08:57 INFO - 'ts_paint', 22:08:57 INFO - 'tpaint', 22:08:57 INFO - 'sessionrestore', 22:08:57 INFO - 'sessionrestore_no_auto_restore']}, 22:08:57 INFO - 'svgr': {'tests': ['tsvgx', 22:08:57 INFO - 'tsvgr_opacity', 22:08:57 INFO - 'tart', 22:08:57 INFO - 'tscrollx', 22:08:57 INFO - 'cart']}, 22:08:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:08:57 INFO - 'tests': ['tsvgx', 22:08:57 INFO - 'tsvgr_opacity', 22:08:57 INFO - 'tart', 22:08:57 INFO - 'tscrollx', 22:08:57 INFO - 'cart']}, 22:08:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:08:57 INFO - 'tests': ['tp5o']}, 22:08:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:08:57 INFO - 'talos_options': ['--e10s'], 22:08:57 INFO - 'tests': ['tp5o']}, 22:08:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:08:57 INFO - 'talos_options': ['--xperf_path', 22:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:08:57 INFO - 'tests': ['tp5n']}, 22:08:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:08:57 INFO - 'talos_options': ['--e10s', 22:08:57 INFO - '--xperf_path', 22:08:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:08:57 INFO - 'tests': ['tp5n']}}, 22:08:57 INFO - 'talos.zip': {'path': '', 22:08:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:08:57 INFO - Running post-action listener: _resource_record_post_action 22:08:57 INFO - ##### 22:08:57 INFO - ##### Running create-virtualenv step. 22:08:57 INFO - ##### 22:08:57 INFO - Running pre-action listener: _resource_record_pre_action 22:08:57 INFO - Running main action method: create_virtualenv 22:08:57 INFO - Creating virtualenv /builds/slave/test/build/venv 22:08:57 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 22:08:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:08:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:08:57 INFO - Using real prefix '/tools/python27' 22:08:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:08:58 INFO - Installing distribute.............................................................................................................................................................................................done. 22:09:02 INFO - Installing pip.................done. 22:09:02 INFO - Return code: 0 22:09:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:02 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 0x10da36490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f70c766c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9599f0>, '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 0x10d6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d94d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/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.UVUh7qSFdo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:09:02 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 22:09:02 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 22:09:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/Render', 22:09:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:02 INFO - 'HOME': '/Users/cltbld', 22:09:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:02 INFO - 'LOGNAME': 'cltbld', 22:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:02 INFO - 'MOZ_NO_REMOTE': '1', 22:09:02 INFO - 'NO_EM_RESTART': '1', 22:09:02 INFO - 'PAGER': '/bin/cat', 22:09:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:02 INFO - 'PWD': '/builds/slave/test', 22:09:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:02 INFO - 'SHELL': '/bin/bash', 22:09:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UVUh7qSFdo/Listeners', 22:09:02 INFO - 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', 22:09:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:02 INFO - 'USER': 'cltbld', 22:09:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:02 INFO - 'XPC_FLAGS': '0x0', 22:09:02 INFO - 'XPC_SERVICE_NAME': '0', 22:09:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:02 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 22:09:02 INFO - Cleaning up... 22:09:02 INFO - Return code: 0 22:09:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:02 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 0x10da36490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f70c766c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9599f0>, '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 0x10d6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d94d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/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.UVUh7qSFdo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:09:02 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 22:09:02 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 22:09:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/Render', 22:09:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:02 INFO - 'HOME': '/Users/cltbld', 22:09:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:02 INFO - 'LOGNAME': 'cltbld', 22:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:02 INFO - 'MOZ_NO_REMOTE': '1', 22:09:02 INFO - 'NO_EM_RESTART': '1', 22:09:02 INFO - 'PAGER': '/bin/cat', 22:09:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:02 INFO - 'PWD': '/builds/slave/test', 22:09:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:02 INFO - 'SHELL': '/bin/bash', 22:09:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UVUh7qSFdo/Listeners', 22:09:02 INFO - 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', 22:09:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:02 INFO - 'USER': 'cltbld', 22:09:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:02 INFO - 'XPC_FLAGS': '0x0', 22:09:02 INFO - 'XPC_SERVICE_NAME': '0', 22:09:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:02 INFO - Downloading/unpacking psutil>=0.7.1 22:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:09:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:09:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:09:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:09:05 INFO - Installing collected packages: psutil 22:09:05 INFO - Running setup.py install for psutil 22:09:05 INFO - building 'psutil._psutil_osx' extension 22:09:05 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 22:09:08 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 22:09:08 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 22:09:08 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 22:09:08 INFO - building 'psutil._psutil_posix' extension 22:09:08 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 22:09:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:09:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:09:08 INFO - ^ 22:09:08 INFO - 1 warning generated. 22:09:08 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 22:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:09:09 INFO - Successfully installed psutil 22:09:09 INFO - Cleaning up... 22:09:09 INFO - Return code: 0 22:09:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:09:09 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')]} 22:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:09 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')]} 22:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:09 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 0x10da36490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f70c766c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9599f0>, '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 0x10d6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d94d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/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.UVUh7qSFdo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:09:09 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 22:09:09 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 22:09:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/Render', 22:09:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:09 INFO - 'HOME': '/Users/cltbld', 22:09:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:09 INFO - 'LOGNAME': 'cltbld', 22:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:09 INFO - 'MOZ_NO_REMOTE': '1', 22:09:09 INFO - 'NO_EM_RESTART': '1', 22:09:09 INFO - 'PAGER': '/bin/cat', 22:09:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:09 INFO - 'PWD': '/builds/slave/test', 22:09:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:09 INFO - 'SHELL': '/bin/bash', 22:09:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UVUh7qSFdo/Listeners', 22:09:09 INFO - 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', 22:09:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:09 INFO - 'USER': 'cltbld', 22:09:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:09 INFO - 'XPC_FLAGS': '0x0', 22:09:09 INFO - 'XPC_SERVICE_NAME': '0', 22:09:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:09:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:09:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:09:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:09:12 INFO - Installing collected packages: mozsystemmonitor 22:09:12 INFO - Running setup.py install for mozsystemmonitor 22:09:12 INFO - Successfully installed mozsystemmonitor 22:09:12 INFO - Cleaning up... 22:09:12 INFO - Return code: 0 22:09:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:09: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')]} 22:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09: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')]} 22:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:12 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 0x10da36490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f70c766c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9599f0>, '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 0x10d6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d94d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/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.UVUh7qSFdo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:09:12 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 22:09:12 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 22:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/Render', 22:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:12 INFO - 'HOME': '/Users/cltbld', 22:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:12 INFO - 'LOGNAME': 'cltbld', 22:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:12 INFO - 'MOZ_NO_REMOTE': '1', 22:09:12 INFO - 'NO_EM_RESTART': '1', 22:09:12 INFO - 'PAGER': '/bin/cat', 22:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:12 INFO - 'PWD': '/builds/slave/test', 22:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:12 INFO - 'SHELL': '/bin/bash', 22:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UVUh7qSFdo/Listeners', 22:09:12 INFO - 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', 22:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:12 INFO - 'USER': 'cltbld', 22:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:12 INFO - 'XPC_FLAGS': '0x0', 22:09:12 INFO - 'XPC_SERVICE_NAME': '0', 22:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:12 INFO - Downloading/unpacking blobuploader==1.2.4 22:09:12 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 22:09:12 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 22:09:12 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 22:09:12 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 22:09:12 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 22:09:12 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 22:09:15 INFO - Downloading blobuploader-1.2.4.tar.gz 22:09:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:09:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:09:15 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 22:09:15 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 22:09:15 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 22:09:15 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 22:09:15 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 22:09:15 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 22:09:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:09:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:09:16 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 22:09:16 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 22:09:16 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 22:09:16 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 22:09:16 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 22:09:16 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 22:09:16 INFO - Downloading docopt-0.6.1.tar.gz 22:09:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:09:17 INFO - Installing collected packages: blobuploader, requests, docopt 22:09:17 INFO - Running setup.py install for blobuploader 22:09:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:09:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:09:17 INFO - Running setup.py install for requests 22:09:17 INFO - Running setup.py install for docopt 22:09:18 INFO - Successfully installed blobuploader requests docopt 22:09:18 INFO - Cleaning up... 22:09:18 INFO - Return code: 0 22:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:09: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')]} 22:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09: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')]} 22:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:18 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 0x10da36490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f70c766c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9599f0>, '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 0x10d6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d94d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/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.UVUh7qSFdo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:09:18 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 22:09:18 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 22:09:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/Render', 22:09:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:18 INFO - 'HOME': '/Users/cltbld', 22:09:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:18 INFO - 'LOGNAME': 'cltbld', 22:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:18 INFO - 'MOZ_NO_REMOTE': '1', 22:09:18 INFO - 'NO_EM_RESTART': '1', 22:09:18 INFO - 'PAGER': '/bin/cat', 22:09:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:18 INFO - 'PWD': '/builds/slave/test', 22:09:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:18 INFO - 'SHELL': '/bin/bash', 22:09:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UVUh7qSFdo/Listeners', 22:09:18 INFO - 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', 22:09:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:18 INFO - 'USER': 'cltbld', 22:09:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:18 INFO - 'XPC_FLAGS': '0x0', 22:09:18 INFO - 'XPC_SERVICE_NAME': '0', 22:09:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:09:18 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-X6MSG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:09:18 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-Qm7feg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:09:18 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-5snL_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:09:18 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-CSWD3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:09:19 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-5622Oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:09:19 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-CoURSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:09:19 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-qtVzDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:09:19 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-1BcHJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:09:19 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-hzTCE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:09:19 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-g71uva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:09:19 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-tjE48C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:09:20 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-x2ldD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:09:20 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-_fzs23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:09:20 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-GUZTmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:20 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-lHxWVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:09:20 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-ZAtQtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:09:20 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-rX2AB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:09:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:09:20 INFO - Running setup.py install for manifestparser 22:09:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:09:21 INFO - Running setup.py install for mozcrash 22:09:21 INFO - Running setup.py install for mozdebug 22:09:21 INFO - Running setup.py install for mozdevice 22:09:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:09:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:09:21 INFO - Running setup.py install for mozfile 22:09:21 INFO - Running setup.py install for mozhttpd 22:09:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:09:21 INFO - Running setup.py install for mozinfo 22:09:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:09:22 INFO - Running setup.py install for mozInstall 22:09:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:09:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:09:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:09:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:09:22 INFO - Running setup.py install for mozleak 22:09:22 INFO - Running setup.py install for mozlog 22:09:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:09:22 INFO - Running setup.py install for moznetwork 22:09:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:09:22 INFO - Running setup.py install for mozprocess 22:09:23 INFO - Running setup.py install for mozprofile 22:09:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:09:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:09:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:09:23 INFO - Running setup.py install for mozrunner 22:09:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:09:23 INFO - Running setup.py install for mozscreenshot 22:09:23 INFO - Running setup.py install for moztest 22:09:23 INFO - Running setup.py install for mozversion 22:09:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:09:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:09:24 INFO - Cleaning up... 22:09:24 INFO - Return code: 0 22:09:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10da36490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f70c766c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9599f0>, '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 0x10d6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d94d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/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.UVUh7qSFdo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:09:24 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 22:09:24 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 22:09:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/Render', 22:09:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:24 INFO - 'HOME': '/Users/cltbld', 22:09:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:24 INFO - 'LOGNAME': 'cltbld', 22:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:24 INFO - 'MOZ_NO_REMOTE': '1', 22:09:24 INFO - 'NO_EM_RESTART': '1', 22:09:24 INFO - 'PAGER': '/bin/cat', 22:09:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:24 INFO - 'PWD': '/builds/slave/test', 22:09:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:24 INFO - 'SHELL': '/bin/bash', 22:09:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UVUh7qSFdo/Listeners', 22:09:24 INFO - 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', 22:09:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:24 INFO - 'USER': 'cltbld', 22:09:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:24 INFO - 'XPC_FLAGS': '0x0', 22:09:24 INFO - 'XPC_SERVICE_NAME': '0', 22:09:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:09:24 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-qFAlMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:09:24 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)) 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:09:24 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-pZ5F8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:09:24 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)) 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:09:24 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-wotWlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:09:24 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)) 22:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:09:24 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-MKlxlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:09:25 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)) 22:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:09:25 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-W3KlqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:09:25 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)) 22:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:09:25 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-7H03jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:09:25 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)) 22:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:09:25 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-FYGR0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:09:25 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)) 22:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:09:25 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-CLmFI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:09:25 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)) 22:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:09:25 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-9vL6eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:09:25 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)) 22:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:09:25 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-9mtGPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:09:25 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-_SaEYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:09:26 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)) 22:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:09:26 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-fe2YHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:09:26 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)) 22:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:09:26 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-8Jufr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:09:26 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)) 22:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:09:26 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-Y4r4ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:09:26 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)) 22:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:26 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-_tRVsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:09:26 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)) 22:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:09:26 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-jkSMSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:09:26 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)) 22:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:09:26 INFO - Running setup.py (path:/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/pip-wU4Ad0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:09:26 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)) 22:09:26 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)) 22:09:26 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)) 22:09:26 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)) 22:09:26 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)) 22:09:26 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)) 22:09:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:09:26 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 22:09:26 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 22:09:26 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 22:09:26 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 22:09:26 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 22:09:26 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 22:09:29 INFO - Downloading blessings-1.5.1.tar.gz 22:09:29 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 22:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:09:29 INFO - Installing collected packages: blessings 22:09:29 INFO - Running setup.py install for blessings 22:09:29 INFO - Successfully installed blessings 22:09:29 INFO - Cleaning up... 22:09:29 INFO - Return code: 0 22:09:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:09:30 INFO - Reading from file tmpfile_stdout 22:09:30 INFO - Current package versions: 22:09:30 INFO - blessings == 1.5.1 22:09:30 INFO - blobuploader == 1.2.4 22:09:30 INFO - docopt == 0.6.1 22:09:30 INFO - manifestparser == 1.1 22:09:30 INFO - mozInstall == 1.12 22:09:30 INFO - mozcrash == 0.16 22:09:30 INFO - mozdebug == 0.1 22:09:30 INFO - mozdevice == 0.47 22:09:30 INFO - mozfile == 1.2 22:09:30 INFO - mozhttpd == 0.7 22:09:30 INFO - mozinfo == 0.9 22:09:30 INFO - mozleak == 0.1 22:09:30 INFO - mozlog == 3.0 22:09:30 INFO - moznetwork == 0.27 22:09:30 INFO - mozprocess == 0.22 22:09:30 INFO - mozprofile == 0.27 22:09:30 INFO - mozrunner == 6.11 22:09:30 INFO - mozscreenshot == 0.1 22:09:30 INFO - mozsystemmonitor == 0.0 22:09:30 INFO - moztest == 0.7 22:09:30 INFO - mozversion == 1.4 22:09:30 INFO - psutil == 3.1.1 22:09:30 INFO - requests == 1.2.3 22:09:30 INFO - wsgiref == 0.1.2 22:09:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:09:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10da36490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da13228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f70c766c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9599f0>, '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 0x10d6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d94d8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/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.UVUh7qSFdo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:09:30 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 22:09:30 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 22:09:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/Render', 22:09:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:09:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:09:30 INFO - 'HOME': '/Users/cltbld', 22:09:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:09:30 INFO - 'LOGNAME': 'cltbld', 22:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:09:30 INFO - 'MOZ_NO_REMOTE': '1', 22:09:30 INFO - 'NO_EM_RESTART': '1', 22:09:30 INFO - 'PAGER': '/bin/cat', 22:09:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:09:30 INFO - 'PWD': '/builds/slave/test', 22:09:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:09:30 INFO - 'SHELL': '/bin/bash', 22:09:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UVUh7qSFdo/Listeners', 22:09:30 INFO - 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', 22:09:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:09:30 INFO - 'USER': 'cltbld', 22:09:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:09:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:09:30 INFO - 'XPC_FLAGS': '0x0', 22:09:30 INFO - 'XPC_SERVICE_NAME': '0', 22:09:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 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)) 22:09:30 INFO - Cleaning up... 22:09:30 INFO - Return code: 0 22:09:30 INFO - Running post-action listener: _resource_record_post_action 22:09:30 INFO - Running post-action listener: _start_resource_monitoring 22:09:30 INFO - Starting resource monitoring. 22:09:30 INFO - ##### 22:09:30 INFO - ##### Running install step. 22:09:30 INFO - ##### 22:09:30 INFO - Running pre-action listener: _resource_record_pre_action 22:09:30 INFO - Running main action method: install 22:09:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:09:31 INFO - Reading from file tmpfile_stdout 22:09:31 INFO - Detecting whether we're running mozinstall >=1.0... 22:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:09:31 INFO - Reading from file tmpfile_stdout 22:09:31 INFO - Output received: 22:09:31 INFO - Usage: mozinstall [options] installer 22:09:31 INFO - Options: 22:09:31 INFO - -h, --help show this help message and exit 22:09:31 INFO - -d DEST, --destination=DEST 22:09:31 INFO - Directory to install application into. [default: 22:09:31 INFO - "/builds/slave/test"] 22:09:31 INFO - --app=APP Application being installed. [default: firefox] 22:09:31 INFO - mkdir: /builds/slave/test/build/application 22:09:31 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'] 22:09:31 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 22:10:12 INFO - Reading from file tmpfile_stdout 22:10:12 INFO - Output received: 22:10:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:10:12 INFO - Running post-action listener: _resource_record_post_action 22:10:12 INFO - ##### 22:10:12 INFO - ##### Running run-tests step. 22:10:12 INFO - ##### 22:10:12 INFO - Running pre-action listener: _resource_record_pre_action 22:10:12 INFO - Running main action method: run_tests 22:10:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:10:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:10:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:10:13 INFO - 2015-11-13 22:10:13.005 screenresolution[1628:8468] starting screenresolution argv=screenresolution get 22:10:13 INFO - 2015-11-13 22:10:13.008 screenresolution[1628:8468] Display 0: 1600x1200x32@60 22:10:13 INFO - 2015-11-13 22:10:13.016 screenresolution[1629:8470] starting screenresolution argv=screenresolution list 22:10:13 INFO - Available Modes on Display 0 22:10:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:10:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:10:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:10:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:10:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:10:13 INFO - Intel HD Graphics 3000: 22:10:13 INFO - Chipset Model: Intel HD Graphics 3000 22:10:13 INFO - Type: GPU 22:10:13 INFO - Bus: Built-In 22:10:13 INFO - VRAM (Total): 512 MB 22:10:13 INFO - VRAM (Dynamic, Max): 10 22:10:13 INFO - Vendor: Intel (0x8086) 22:10:13 INFO - Device ID: 0x0116 22:10:13 INFO - Revision ID: 0x0009 22:10:13 INFO - Displays: 22:10:13 INFO - Display: 22:10:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:10:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:10:13 INFO - Display Serial Number: 1600x1200 60 22:10:13 INFO - Main Display: Yes 22:10:13 INFO - Mirror: Off 22:10:13 INFO - Online: Yes 22:10:13 INFO - Rotation: Supported 22:10:13 INFO - Return code: 0 22:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:10:13 INFO - Python 2.7.3 22:10:13 INFO - Return code: 0 22:10:13 INFO - grabbing minidump binary from tooltool 22:10:13 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')]} 22:10:13 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 0x10d9599f0>, '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 0x10d6b9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d94d8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:10:13 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 22:10:13 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 22:10:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:10:13 INFO - Return code: 0 22:10:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:10:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:10:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:10:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:10:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0104', '--webServer', 'localhost'] in /builds/slave/test/build 22:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0104 --webServer localhost 22:10:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.erwtkdXTIv/Render', 22:10:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:10:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:10:13 INFO - 'HOME': '/Users/cltbld', 22:10:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:10:13 INFO - 'LOGNAME': 'cltbld', 22:10:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:10:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:10:13 INFO - 'MOZ_NO_REMOTE': '1', 22:10:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:10:13 INFO - 'NO_EM_RESTART': '1', 22:10:13 INFO - 'PAGER': '/bin/cat', 22:10:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:10:13 INFO - 'PWD': '/builds/slave/test', 22:10:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:10:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:10:13 INFO - 'SHELL': '/bin/bash', 22:10:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UVUh7qSFdo/Listeners', 22:10:13 INFO - 'TMPDIR': '/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/', 22:10:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:10:13 INFO - 'USER': 'cltbld', 22:10:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:10:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:10:13 INFO - 'XPC_FLAGS': '0x0', 22:10:13 INFO - 'XPC_SERVICE_NAME': '0', 22:10:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 22:10:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0104', '--webServer', 'localhost'] with output_timeout 3600 22:10:13 INFO - mozversion INFO | application_buildid: 20151113211931 22:10:13 INFO - mozversion INFO | application_changeset: 81de57cbfed15c61062f2292cef14caf9c21d989 22:10:13 INFO - mozversion INFO | application_display_name: Nightly 22:10:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:10:13 INFO - mozversion INFO | application_name: Firefox 22:10:13 INFO - mozversion INFO | application_remotingname: firefox 22:10:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:10:13 INFO - mozversion INFO | application_vendor: Mozilla 22:10:13 INFO - mozversion INFO | application_version: 45.0a1 22:10:13 INFO - mozversion INFO | platform_buildid: 20151113211931 22:10:13 INFO - mozversion INFO | platform_changeset: 81de57cbfed15c61062f2292cef14caf9c21d989 22:10:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:10:13 INFO - mozversion INFO | platform_version: 45.0a1 22:10:13 INFO - 2015-11-13 22:10:13,784 DEBUG : using testdate: 1447481413 22:10:13 INFO - 2015-11-13 22:10:13,785 DEBUG : actual date: 1447481413 22:10:13 INFO - 2015-11-13 22:10:13,794 INFO : starting webserver on 'localhost:49264' 22:10:13 INFO - 2015-11-13 22:10:13,795 INFO : Starting test suite t-yosemite-r5-0104.e 22:10:13 INFO - 2015-11-13 22:10:13,795 INFO : Starting test dromaeo_css 22:10:13 INFO - 2015-11-13 22:10:13,795 DEBUG : operating with platform_type : mac_ 22:10:13 INFO - 2015-11-13 22:10:13,796 INFO : Initialising browser for dromaeo_css test... 22:10:13 INFO - 2015-11-13 22:10:13,823 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/tmpTvQJGP/profile http://localhost:49264/getInfo.html 22:10:18 INFO - 2015-11-13 22:10:18,219 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:10:18 INFO - 2015-11-13 22:10:18,220 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:10:18 INFO - 2015-11-13 22:10:18,220 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:10:18 INFO - 2015-11-13 22:10:18,220 DEBUG : BROWSER_OUTPUT: __metrics 22:10:18 INFO - 2015-11-13 22:10:18,971 INFO : Browser initialized. 22:10:18 INFO - 2015-11-13 22:10:18,971 INFO : Running cycle 1/1 for dromaeo_css test... 22:10:18 INFO - 2015-11-13 22:10:18,972 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/tmpTvQJGP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:10:31 INFO - 2015-11-13 22:10:31,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 241266688 22:10:31 INFO - 2015-11-13 22:10:31,163 DEBUG : BROWSER_OUTPUT: 22:11:21 INFO - 2015-11-13 22:11:21,009 DEBUG : BROWSER_OUTPUT: 1447481481004 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] 22:13:32 INFO - 2015-11-13 22:13:32,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 22:13:33 INFO - 2015-11-13 22:13:33,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 265764864 22:13:33 INFO - 2015-11-13 22:13:33,373 DEBUG : BROWSER_OUTPUT: 22:16:35 INFO - 2015-11-13 22:16:35,612 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 22:16:36 INFO - 2015-11-13 22:16:36,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 272535552 22:16:36 INFO - 2015-11-13 22:16:36,204 DEBUG : BROWSER_OUTPUT: 22:19:38 INFO - 2015-11-13 22:19:38,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 22:19:38 INFO - 2015-11-13 22:19:38,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 272924672 22:19:38 INFO - 2015-11-13 22:19:38,599 DEBUG : BROWSER_OUTPUT: 22:22:40 INFO - 2015-11-13 22:22:40,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 22:22:40 INFO - 2015-11-13 22:22:40,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 278056960 22:22:40 INFO - 2015-11-13 22:22:40,931 DEBUG : BROWSER_OUTPUT: 22:25:43 INFO - 2015-11-13 22:25:43,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 22:25:44 INFO - 2015-11-13 22:25:44,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 284024832 22:25:44 INFO - 2015-11-13 22:25:44,169 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-11-13 22:28:46,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 22:28:46 INFO - 2015-11-13 22:28:46,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 287883264 22:28:46 INFO - 2015-11-13 22:28:46,749 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-11-13 22:28:46,749 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:28:46 INFO - 2015-11-13 22:28:46,749 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:28:46 INFO - 2015-11-13 22:28:46,749 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:28:46 INFO - 2015-11-13 22:28:46,749 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:28:46 INFO - 2015-11-13 22:28:46,750 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2654.5221860065185;2706.526357887369;2723.428080103178;2724.8637568121594;2787.1220565521858;4497.1455423469515;4533.478649955252;4574.2223821950265;4582.335561343607;4627.907441851161;4403.075354175619;4488.214562451566;4519.299508576176;4522;4586.8394606188795;4160.56314087021;4239.321708526636;4270.786460676969;4327.480702315726;4354.303311470166;4177.979110104445;4304.203722311367;4315.978420107895;4336.21948049351;4376.212281789277;4079.9184016319805;4147.751134931914;4154.169166166779;4245.257080010986;4314.417553630266;4091.2226676931587;4135.29699951009;4192.434021407102;4201.34879093741;4220.894477638053;4124.505059392892;4201.68487363449;4210.59999300066;4239.894002649928;4286.57134286572;4353.564643535653;4364.2798938175165;4372.846950356754;4540.659450541222;4543.8182472701055;4848.733319667417;4903.53416425439;4905.901881962376;4917.164082106015;4946.826861059882;4876.878078048042;4915.115279249733;4955.925661115086;4979.7759100840185;4990.30135780991;4370.2133615949115;4433.135538570013;4475.194464996332;4489.124620698933;4662.160811054009;5015.322931404214;5086.0845047891;5089.541941225233;5104.05574968632;5154.793808247703;4791.065742180311;4822.565969062801;4859.878503037452;4885.267209918541;4887.804487820447;4501.3022981437925;4753.47711751707;4822.132016237111;4878.682885612424;4901.313816065754;4807.4471435785335;4836.008618233253;4852.223644216909;4917.704937703677;4924.4583095859425;4693.906121877543;4818.036392721469;4838.854834354975;4864.73243971585;4947.035328110984;3699.5560532736245;3709.888703338904;3769.981150094287;3790.4124860646643;3798.962010379916;3397.6262611112757;3410.9658903411146;3453.4129198036394;3465.2203254268093;3493.318802833423;4494.595486406239;4529.38853254813;4579.610733087658;4706.317583950308;4766.285057241442;4833.347498087784;4879.39007624047;4881.95118048822;4905.607551395879;4918.163912134874;4603.930941035887;4644.16405047088;4652.32541281519;4687.789049492712;4749.121412538691;4175;4178.143480586473;4280.315149576053;4288.849890253826;4319.136172765459;5067.8986420271385;5078.263651770547;5125;5151.974240128776;5159.871003224949;4940.481249468754;4941.481144479778;4967.577755890645;4986.252062190701;5010.824621138243;4842.806287748451;4882.145624515624;4993.80024799004;5082.618803589671;5130.307408499804;4821.368881616098;4823.517648235148;4912.459629440687;4931.186354251508;4955.776990035529;4895.388076490439;4906.607471402208;4953.653244272867;4961.454240033666;4975.203967365204;4479.910401792011;4648.860534183845;4686.437627484587;4753.857384278477;4761.047790441995;4626.167289887852;4713.693609915482;4747.762611869462;4774.21225497789;4786.641001924939;4632.5830675239395;4683.742394168354;4712.59942904857;4743.169945259497;4795.448523419851;4522.683412161117;4711.104890070876;4815.349927759848;4850.854474365775;4892.730899800546;4608.170529304623;4638.83764068256;4648.418947631546;4670.252759558454;4677.204875171297 22:28:46 INFO - 2015-11-13 22:28:46,750 DEBUG : BROWSER_OUTPUT: |1;ext.html;469.91776439123146;477.7873846138468;479.0490875611912;498.7780437705222;510.041122689344;32343;33597;33673.32653346938;33702;33708;36357.27285454289;36652.63347366526;36661.816690916574;36666.26667466649;36717.44923826145;7815.609219539015;7980.840383192332;7990.480618759762;8017.078036025873;8037.23646253605;7765.06819181699;7899.052113746358;7900.130985591609;7909.248621380988;7914.564698941556;6972.51192416531;6974.337437943387;7003.47473939454;7004;7031.296870312979;7824.765257042298;7897;7901.48640338379;7912.564808935506;7914.881276780853;7670.8465830683635;7800.336971357441;7819.804504887424;7823.921760782377;7836.098848632366;33618.310535157376;34048.31903361944;34062.48906266408;34083.14792130192;34089;2385.2248019393764;2510.585753350695;2751.312171957011;2773.9583906241423;2978.7021297870256;23383.88308058466;23521.29436116919;23552;23931.760682393127;23954.16160434394;2063.123172651632;2064.5457999240293;2068.503559145809;2083.468715477559;2117.142557264295;224670;227367;227915;228626;229046.99999999834;42756.358654620206;43769;47663;48041.27938080932;52834.47165528373;49501.75249123731;50378.748106259234;50673.49326506688;50684;51291.48708512942;13018.349082546025;13340;13514.189148650916;13520.864791352158;13526.053176277566;10078.798424031478;10107.393556386492;10218.489075546193;10291.742706432398;10316.535755891004;15638.296276667577;15820.76268855968;16019.519414417586;16083.195840207944;16113.919430402773;6727.596344219362;6864.24493305736;6877;6888.104546409035;6993.300669932966;796.2555011064674;801.9198080191934;808.9514629122272;864.7362554420962;877.4954401219325;20682.482937926674;20997.580048398948;21180.25869094605;21298.25456109029;23920.282391528282;894.351595093552;907.7276816955019;927.8190752803139;958.9664361747306;999.8450240212778;11407.771844563229;11516.366599837089;11529.654110376701;11530.942345288388;11669.591564295379;194670;199560;200692.9965350193;200865;201065;40178.799106004284;40468.595314046484;40922;41068.58931410708;44196.55803441989;1183.7454947186395;1184.0764203920955;1185.3065956415421;1188.4948896719034;1194.5818963362753;22210.111595535996;22622.773772262066;22845.200417985954;22859.771402285765;22915.65626515637;37443.43834842425;37838.62161378351;37851.810740946115;37861;38358.6164138355;241396;242253;243036;243942;245015;25084;41083;42695.786521067195;42814;42872;37626.62373376341;39082.41376379413;39735.80132099437;40019.599804002755;40861;32374.19064523406;32773.836130819196;32815.50776738303;32848.50727239141;32970.340593188484;31414.68585314209;32617.18457038498;32851.8357408221;33034.17414564655;33284.1678958028;33223.501647474826;33708.66291337055;34960.245376850246;36072.81963590165;36642.8167859159;27564.31089222705;28893.56659650065;28922;29064.273393164494;29269;21679;22095.44761380978;22110.557788844453;22133.225337113123;22276.220332288292 22:28:46 INFO - 2015-11-13 22:28:46,751 DEBUG : BROWSER_OUTPUT: |2;jquery.html;282.30834455583823;285.4234446418235;286.48289836844486;289.2277618757916;290.08333665616647;12467.314297713621;13962.650933726649;14450.710985780292;14481.493147739831;15041.172735499544;14713.117212967203;14800;15006.924965375158;15011.924940375282;15169.317380717866;4490.304002879542;4516.796744146522;4646;4655.231886738684;4708.223143181371;4591.196540605398;4643.8142474300985;4645.512221216757;4650.116477869194;4707.7175369477945;2813;2852.614896988901;4670.065986802653;4671.929921051187;4727.810887564493;4006.479157709494;4106.897327566835;4122.670186385082;4128.6284234419045;4131.153113611717;3501.212227248874;3501.824908754552;3506.158521954738;3506.719462443024;3534.7348948828685;10480.213983951235;11070.446477676083;11077.556897724082;11078.612248571262;11079.335239885633;1615.240836806699;1648.5301689018693;1652.5785924589152;1678.5887457572974;1709.6837085139289;8015.158408367154;8220.547869867154;8283;8398.538080405575;8428.072911979678;1285.3573213393304;1315.5790147152916;1323.5764555342294;1331.0815537279245;1336.565616174747;45038.54961450409;45585.316220256726;45747.999999999665;46088.769556152;46368.76815615934;5487.945120548823;5513.365962914236;5593.972030139823;5601.803936862272;5659.377468478464;6302.180716506825;6412.294647588761;6421.325760795143;6422.903656445157;6424.357564243538;4611.377464042312;4632.72203667781;4643.349931009661;4698.882527936829;4715.834945776881;4963.528464795839;4970.751462426936;5046.243063540425;5083.644144909821;5088.262201980692;2476.7151777545814;2521.8360806547885;2532.962005569918;2533.1640558615613;2581.2127301172945;893.1871996483169;897.3763234551924;898.2499612823366;904.2268860124499;951.6907005223192;359.53799367812235;362.98003609801714;369.5030184402029;391.15120189189525;392.6995848176148;8621.267192288726;9236.7690807729;9692.515374231401;10012.349197302152;10170.491475426199;386.0541672901403;394.0444422275969;394.40248024243294;395.7150851386997;402.523010232875;5242.16125419931;5332.600054995891;5349.592683292534;5416;5422.91865622016;398869;399410;407663.7700868979;410641;411144;56805.431945680844;57026;57669;58509.41490585125;58810.70594646999;389.2099038950934;392.90766669832567;392.9783861887624;393.9940900886546;394.02085816745364;9240.537973101453;9253.768655783659;9254.4910029949;9308.348415611114;9471.28965327617;26788.464230715665;28013.719862801925;28239.717602823708;28409.43181136407;29128.854355728086;38111.80944095262;38456.2308753829;38752.41871371988;38785;38883.416748749354;5200.193969934666;5224.111900976767;5311.804843910089;5312.468753124656;5321.201819727072;9913.355631883904;10041.548130334006;10051;10076.042775936274;10158.492075396052;8574.571271436278;8668.696595619123;8701.47791132534;8746.562671866508;8790.912090879265;7031.402330801735;7512.399008079231;8199;8347.749567512985;8720.694775682821;8539.8719019216;8707.564621769014;8749.212570868653;8760.474371537728;8760.561971901507;5329.253904453302;5336.839894803162;5359.732013399393;5404.621676482766;5416.187571864094;8548.444351117158;8583.570821458778;8923.687670931486;8940.776480588038;9001.279897608307 22:28:46 INFO - 2015-11-13 22:28:46,755 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1473.1676602719456;1486.821581410231;1518.559617710864;1530.0054964273222;1558.2987655554996;5809.070548712207;5851.912221316684;6487.837804054901;6943;6961.582305061694;6200.255969283692;6221.937780622193;6480.060391243267;6481.222253329607;6498.350164983499;1842.622262436204;1847.8336949674526;1871.831535161835;1875.5779949511318;1879.7274395212687;1830.7528483654735;1883.3408307092477;1891.5838515526632;1907.7806052304024;1917.2906024770784;1860.5162657708959;1866.5426970392205;1871.2795573704154;1894.4222012286248;1895.516643255968;1841.3003058837623;1873.316239572553;1877.7840548336978;1897.6299621573799;1898.876573022756;1821.5628249220224;1836.9816301837077;1840.6778813707547;1845.8800177988387;1908.895010774407;6554.410103090745;6620.966895165541;6666.799996000128;6694.899576506356;6708.12794336738;3975.7614543127215;3992.6007399260134;4009.799510024516;4062.1875624875142;4076.9388459173138;2363.7518060603734;2487.7761001509953;2531.658226139466;2535.9239222823344;2539.898404063835;746.7685017644548;762.0893032825776;762.3824701991405;764.3121190928154;770.3990887108065;8895.866562001574;8898.4660920345;8925.464472131627;9030.458172509605;9063.50150741709;3433.828308584561;3457.9827100864336;3501.142220156078;3573.535440392732;3617.439296908983;7317.780466586011;7325.963370183115;7377.557346559223;7425.517341372793;7444.702211911571;3919.098607320332;3966.5835087315995;3969.622885825842;3970.82131304092;3983.701222408331;3110.751139908802;3168.683131686813;3592.2995015971633;3625.8549658013912;3663.816809159585;2856.1003283965483;2955.6453225612636;2962.066948911086;3007.3985202959057;3019.4866872631706;861.0227391910227;873.214107303432;874.0429229993148;874.6545114679793;875.382855087162;853.9615717292737;859.4155973937658;869.5000374784398;885.3536918049859;918.3433844801;6296.087067375205;6423.807285781434;6494.545381823227;6516.315786842408;6537.869242615121;958.4776296918196;976.0776066616979;991.9008099190023;1011.2516737614112;1016.6340117557673;4896.681715688469;4978.253262010655;4996.775145118479;5094.465081166424;5132.923006154911;7978.481398709066;8043.919560804434;8132.959335203286;8201.22088401601;8224.712135075244;7899.091604465445;7903;8013.679452821939;8094.190580941859;8114.269715725613;6286.654234017173;6348.968255158787;6364.64994425311;6373.617582945131;6381.489480841522;5885.676287804212;5991.131285963424;6020.789272375446;6120.693965301806;6126.417990290915;6844.794656160323;7089.680964356719;7117.181524124792;7124.5725256484775;7155.391791697556;7204.783856484314;7306.96346518264;7308.1595616502655;7371.705131794668;7376.889346659697;4848.9757551212015;5339.119045357628;5562.638428502134;5565.860853478695;5578.525825304894;6216.44052035319;6340.302566717565;6368.426841584094;6431.099646049463;6431.453326467303;5568.1091025435735;5941.702914854326;5975.462208401264;5996.610220335664;6036.849078773066;5834.94165058344;5927.496162826035;5985.700714964321;6014.548908831767;6049.153118563493;5942.346341902474;6045.335013148638;6061.030235162353;6091.390860914051;6100.481459076028;5247.947520524898;5381;5389.946100539101;5391.649542779707;5402.621816472966;5464.890702186013;5487.451254874641;5525.751341189576;5528.032594296063;5538.944610554004 22:28:46 INFO - 2015-11-13 22:28:46,756 DEBUG : BROWSER_OUTPUT: |4;prototype.html;261.359668811412;265.93750468639865;266.7066227150135;268.56626548124785;278.1419321393501;5319.840404787853;5355.0628639987945;5503.779848806048;5507.669539827608;5507.807226747064;5227.817026404076;5377.865553361168;5394.91907621386;5396.379416367119;5401.648892821964;4082.3060079786505;4109.6438175402045;4114.136031433388;4132.710710250284;4164.208800327943;4131.277026520362;4134.689898257643;4136.400221967813;4145.54399016108;4145.875623731293;3886.1061955750192;4088.080181959065;4095.1809638072355;4097.959020409788;4103.938440923389;3996.540397854255;4041.11095558978;4045.0089728016824;4049.0564529025937;4074.2055299216663;3454.758166928316;3456.343294773985;3459.5502584664086;3461.8442170102408;3464.8960531184107;5083.822066227701;5243.973780131075;5258.763355649005;5260.631755777097;5285.07511185541;4432.180046691373;4465.59809617136;4471.575200355961;4475.328700694922;4486.170058539181;5603.579731520153;5604.635698679573;5613.7193140342815;5628.690422026787;5629.352624448159;3632.1282892105705;3634.800085995269;3635;3640.5813331466957;3685.7788532688123;5696.316442026942;5812.564057695689;5873.559483038746;5886;5937.881242375129;3799.3920972644246;3803.54357477099;3805.5052843130215;3808.6572208500816;3812.066043819282;3794.962050379516;3872.496575445174;3883.436901649245;3883.8446462141196;3890.377539593708;4489.663275254369;4508.819647214074;4510.368548403226;4517.932231016537;4521.163584736834;5294.470552944752;5410.83767486976;5474.863128421742;5609.046462101453;5615.848751006034;1349.5276653171509;1358.110437663332;1375.8624137586162;1379.165604809076;1380.4064252371577;833.7873842170208;848.2577744473585;850.5959669157224;864.8313578852063;892.0588778838388;5424.972875135678;5470.343558772973;5476;5479.506844383945;5497.505224529811;5891.175235467038;5893.616914900518;5893.823185304448;5904.527637788967;5962.25471816023;5406.6215364924865;5473.863153421196;5488.780448782004;5492.203630473638;5504.146857237135;3091.6599174091284;3146.7797254192446;3162.446571849917;3197.0249074032176;3212.566303549038;6132.08018797184;6140.5701600887505;6140.815775526741;6143.139960405547;6149.385061493815;6048.758049678052;6061.121137435047;6062.545309101835;6065.3934606539;6099.603525770811;5926.547995740985;6135.355787642323;6135.969320153371;6180.134781130645;6188.164597779422;5916.142159386951;5938.881222375615;5949.167116603766;5960.940390596039;5976.163337132892;5795.072788353843;5802.6808525531505;5822.679752613647;5831.70841457917;5876.941230587639;6033.9698301508215;6116.847078823065;6126.142340072304;6128.4790792783115;6134;3708.351038568294;3792.9620703792607;3828.4831547741815;3834.5973672765076;3844.2695887781233;5618.578606604439;5866.767978724516;5867.354590995073;5890.823275301748;5895;5457.69982650958;5571.470710282517;5678.659280443187;5717.371089180104;5725.484706376279;5707.400722924033;5719.056355701429;5720.08478643415;5720.628159169641;5733.942660573508;5557;5573.665580065209;5576.302962129734;5580.135079062752;5581.693006884498;5494.560435165097;5689.487946084872;5689.943100569107;5691.544676425793;5700.657960522382;5596.384397716167;5598.1322894951345;5598.888022239614;5606.327240731139;5616.634918730269 22:28:46 INFO - 2015-11-13 22:28:46,757 DEBUG : BROWSER_OUTPUT: |5;yui.html;559.5076332827113;604.1240201707523;631.2078341681189;632.3328888023136;640.9070684750715;11512.769744605113;11733.237339572943;11809.641891182517;11827.34949577773;11888.702782430444;9672.903270967288;9761.267904907143;9869.259805514597;11242.269252498581;11242.887571124287;600.093858274005;605.4429924469476;758.4993904023332;763.73651090374;767.9385649148082;725.92377800331;744.4639859301294;760.98858517122;773.1186447449911;776.6621519638946;776.4952780692566;779.5478622398995;784.274546044909;792.0178978067185;795.5187111797337;780.75406247032;781.812365032391;782.9882551761729;783.2676447521557;794.8171920458327;576.766409604111;581.3024370755111;584.0305093544738;584.1208980484344;594.6283572767021;11621.128415368881;11763.58827441044;11867.58463453775;11921.523139074427;11982.101342399355;8846.469211847245;9333;9403.764905877408;9685.564149613285;10446.791064178673;7743.380529557622;8127.2279133482225;8135.3491720662205;8177.100518942971;8179.059408168077;2694.568868980973;2791.860406979643;2913.1697466222236;2921.7370436660804;2940;40223;40481.79759101215;40897.18205635871;41113.383299250534;41119.38320925159;7687.423443241779;7705.460617756703;7721.189275126143;7964.362850971908;8135;16091.839081609034;16092.75860862088;16139.35442582307;16152.192390380435;16276.674466510603;5576.832695019156;5607.383187849333;5791.189233507313;5840.591158618856;5855.297364316224;2989.5216765317446;3048.6036815214325;3142.041677288449;3164.193130751644;3174.714275715197;2390.2590197038626;2471.740467250913;2472.394263405477;2475.504899020203;2475.6905386826647;343.4813431718074;351.0259031188472;360.9927801443956;363.9181184233526;364.797537366764;318.9457792175336;459.1559052001372;475.59099174709723;476.40449438202245;502.29678450170053;6338;6864.897026544606;6930;6961.860762784716;7019.0875186226485;380.44075209442076;393.21357285429144;421.49631190726785;428.36601829292823;509.68144909431606;3215.453372926608;3259.071164718044;3569.4824250484053;3620.7465477416854;3642.307961487309;50392.4882253533;50623.24065139026;51321;51361.48638513642;51836.22245666318;44777.55222447734;45122.54877451249;45227.77386113048;45388.546114539095;45522.77238613852;39418.408723869165;40156;40251.39622905659;40721.79639101786;40745.592544074774;7110.57336559808;7113.82215444618;7124.536905101152;7190.316919892602;7202.89195662076;29067.56398654064;29405.26486837846;29917.70082299149;29938.401231974804;30725.846370768002;39437;40237.39643905285;40544.1891162181;40552.18895622012;40612.59387406088;6578.111954886029;6652.900206497004;6672.83317917056;6790.558613690095;7028.789136325919;9055.501947392693;9072.818543629222;9282.489463079595;9486.905130948879;9929.255305851946;8908.777280567778;8998.055204203465;9003.684871029482;9250.126169882038;9832.852507212541;8875.822483550422;8933.19601235892;8934;9126.556171259492;9510.857337140087;8819.735407937773;8955.104489550993;9113.134252246025;9153.07054106639;9502.287328450255;7612.276833700789;7827.491213071132;7857.253560911704;7881.802954926173;8163.673453062049;7315.670794814353;7974.641141148546;8051.798705032421;8313.83372332562;8316.916830831615 22:28:46 INFO - 2015-11-13 22:28:46,758 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:28:46 INFO - 2015-11-13 22:28:46,758 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:28:46 INFO - 2015-11-13 22:28:46,758 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,293 22:28:46 INFO - 2015-11-13 22:28:46,759 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:28:46 INFO - 2015-11-13 22:28:46,760 DEBUG : BROWSER_OUTPUT: __startTimestamp1447482526743__endTimestamp 22:28:46 INFO - 2015-11-13 22:28:46,760 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-11-13 22:28:46,760 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:28:46 INFO - 2015-11-13 22:28:46,760 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:28:46 INFO - 2015-11-13 22:28:46,760 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-11-13 22:28:46,761 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4549.58 Median:4683.74 stddev:497.06 (10.6%) stddev-sans-first:475.84 22:28:46 INFO - 2015-11-13 22:28:46,761 DEBUG : BROWSER_OUTPUT: Values: 2654.5 2706.5 2723.4 2724.9 2787.1 4497.1 4533.5 4574.2 4582.3 4627.9 4403.1 4488.2 4519.3 4522.0 4586.8 4160.6 4239.3 4270.8 4327.5 4354.3 4178.0 4304.2 4316.0 4336.2 4376.2 4079.9 4147.8 4154.2 4245.3 4314.4 4091.2 4135.3 4192.4 4201.3 4220.9 4124.5 4201.7 4210.6 4239.9 4286.6 4353.6 4364.3 4372.8 4540.7 4543.8 4848.7 4903.5 4905.9 4917.2 4946.8 4876.9 4915.1 4955.9 4979.8 4990.3 4370.2 4433.1 4475.2 4489.1 4662.2 5015.3 5086.1 5089.5 5104.1 5154.8 4791.1 4822.6 4859.9 4885.3 4887.8 4501.3 4753.5 4822.1 4878.7 4901.3 4807.4 4836.0 4852.2 4917.7 4924.5 4693.9 4818.0 4838.9 4864.7 4947.0 3699.6 3709.9 3770.0 3790.4 3799.0 3397.6 3411.0 3453.4 3465.2 3493.3 4494.6 4529.4 4579.6 4706.3 4766.3 4833.3 4879.4 4882.0 4905.6 4918.2 4603.9 4644.2 4652.3 4687.8 4749.1 4175.0 4178.1 4280.3 4288.8 4319.1 5067.9 5078.3 5125.0 5152.0 5159.9 4940.5 4941.5 4967.6 4986.3 5010.8 4842.8 4882.1 4993.8 5082.6 5130.3 4821.4 4823.5 4912.5 4931.2 4955.8 4895.4 4906.6 4953.7 4961.5 4975.2 4479.9 4648.9 4686.4 4753.9 4761.0 4626.2 4713.7 4747.8 4774.2 4786.6 4632.6 4683.7 4712.6 4743.2 4795.4 4522.7 4711.1 4815.3 4850.9 4892.7 4608.2 4638.8 4648.4 4670.3 4677.2 22:28:46 INFO - 2015-11-13 22:28:46,761 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-11-13 22:28:46,761 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37580.37 Median:33687.66 stddev:58303.72 (173.1%) stddev-sans-first:58400.69 22:28:46 INFO - 2015-11-13 22:28:46,763 DEBUG : BROWSER_OUTPUT: Values: 469.9 477.8 479.0 498.8 510.0 32343.0 33597.0 33673.3 33702.0 33708.0 36357.3 36652.6 36661.8 36666.3 36717.4 7815.6 7980.8 7990.5 8017.1 8037.2 7765.1 7899.1 7900.1 7909.2 7914.6 6972.5 6974.3 7003.5 7004.0 7031.3 7824.8 7897.0 7901.5 7912.6 7914.9 7670.8 7800.3 7819.8 7823.9 7836.1 33618.3 34048.3 34062.5 34083.1 34089.0 2385.2 2510.6 2751.3 2774.0 2978.7 23383.9 23521.3 23552.0 23931.8 23954.2 2063.1 2064.5 2068.5 2083.5 2117.1 224670.0 227367.0 227915.0 228626.0 229047.0 42756.4 43769.0 47663.0 48041.3 52834.5 49501.8 50378.7 50673.5 50684.0 51291.5 13018.3 13340.0 13514.2 13520.9 13526.1 10078.8 10107.4 10218.5 10291.7 10316.5 15638.3 15820.8 16019.5 16083.2 16113.9 6727.6 6864.2 6877.0 6888.1 6993.3 796.3 801.9 809.0 864.7 877.5 20682.5 20997.6 21180.3 21298.3 23920.3 894.4 907.7 927.8 959.0 999.8 11407.8 11516.4 11529.7 11530.9 11669.6 194670.0 199560.0 200693.0 200865.0 201065.0 40178.8 40468.6 40922.0 41068.6 44196.6 1183.7 1184.1 1185.3 1188.5 1194.6 22210.1 22622.8 22845.2 22859.8 22915.7 37443.4 37838.6 37851.8 37861.0 38358.6 241396.0 242253.0 243036.0 243942.0 245015.0 25084.0 41083.0 42695.8 42814.0 42872.0 37626.6 39082.4 39735.8 40019.6 40861.0 32374.2 32773.8 32815.5 32848.5 32970.3 31414.7 32617.2 32851.8 33034.2 33284.2 33223.5 33708.7 34960.2 36072.8 36642.8 27564.3 28893.6 28922.0 29064.3 29269.0 21679.0 22095.4 22110.6 22133.2 22276.2 22:28:46 INFO - 2015-11-13 22:28:46,763 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-11-13 22:28:46,763 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:20928.54 Median:4622.05 stddev:66418.39 (1437.0%) stddev-sans-first:66586.61 22:28:46 INFO - 2015-11-13 22:28:46,766 DEBUG : BROWSER_OUTPUT: Values: 282.3 285.4 286.5 289.2 290.1 12467.3 13962.7 14450.7 14481.5 15041.2 14713.1 14800.0 15006.9 15011.9 15169.3 4490.3 4516.8 4646.0 4655.2 4708.2 4591.2 4643.8 4645.5 4650.1 4707.7 2813.0 2852.6 4670.1 4671.9 4727.8 4006.5 4106.9 4122.7 4128.6 4131.2 3501.2 3501.8 3506.2 3506.7 3534.7 10480.2 11070.4 11077.6 11078.6 11079.3 1615.2 1648.5 1652.6 1678.6 1709.7 8015.2 8220.5 8283.0 8398.5 8428.1 1285.4 1315.6 1323.6 1331.1 1336.6 45038.5 45585.3 45748.0 46088.8 46368.8 5487.9 5513.4 5594.0 5601.8 5659.4 6302.2 6412.3 6421.3 6422.9 6424.4 4611.4 4632.7 4643.3 4698.9 4715.8 4963.5 4970.8 5046.2 5083.6 5088.3 2476.7 2521.8 2533.0 2533.2 2581.2 893.2 897.4 898.2 904.2 951.7 359.5 363.0 369.5 391.2 392.7 8621.3 9236.8 9692.5 10012.3 10170.5 386.1 394.0 394.4 395.7 402.5 5242.2 5332.6 5349.6 5416.0 5422.9 398869.0 399410.0 407663.8 410641.0 411144.0 56805.4 57026.0 57669.0 58509.4 58810.7 389.2 392.9 393.0 394.0 394.0 9240.5 9253.8 9254.5 9308.3 9471.3 26788.5 28013.7 28239.7 28409.4 29128.9 38111.8 38456.2 38752.4 38785.0 38883.4 5200.2 5224.1 5311.8 5312.5 5321.2 9913.4 10041.5 10051.0 10076.0 10158.5 8574.6 8668.7 8701.5 8746.6 8790.9 7031.4 7512.4 8199.0 8347.7 8720.7 8539.9 8707.6 8749.2 8760.5 8760.6 5329.3 5336.8 5359.7 5404.6 5416.2 8548.4 8583.6 8923.7 8940.8 9001.3 22:28:46 INFO - 2015-11-13 22:28:46,766 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-11-13 22:28:46,767 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4594.75 Median:5980.58 stddev:2407.51 (40.3%) stddev-sans-first:2402.84 22:28:46 INFO - 2015-11-13 22:28:46,767 DEBUG : BROWSER_OUTPUT: Values: 1473.2 1486.8 1518.6 1530.0 1558.3 5809.1 5851.9 6487.8 6943.0 6961.6 6200.3 6221.9 6480.1 6481.2 6498.4 1842.6 1847.8 1871.8 1875.6 1879.7 1830.8 1883.3 1891.6 1907.8 1917.3 1860.5 1866.5 1871.3 1894.4 1895.5 1841.3 1873.3 1877.8 1897.6 1898.9 1821.6 1837.0 1840.7 1845.9 1908.9 6554.4 6621.0 6666.8 6694.9 6708.1 3975.8 3992.6 4009.8 4062.2 4076.9 2363.8 2487.8 2531.7 2535.9 2539.9 746.8 762.1 762.4 764.3 770.4 8895.9 8898.5 8925.5 9030.5 9063.5 3433.8 3458.0 3501.1 3573.5 3617.4 7317.8 7326.0 7377.6 7425.5 7444.7 3919.1 3966.6 3969.6 3970.8 3983.7 3110.8 3168.7 3592.3 3625.9 3663.8 2856.1 2955.6 2962.1 3007.4 3019.5 861.0 873.2 874.0 874.7 875.4 854.0 859.4 869.5 885.4 918.3 6296.1 6423.8 6494.5 6516.3 6537.9 958.5 976.1 991.9 1011.3 1016.6 4896.7 4978.3 4996.8 5094.5 5132.9 7978.5 8043.9 8133.0 8201.2 8224.7 7899.1 7903.0 8013.7 8094.2 8114.3 6286.7 6349.0 6364.6 6373.6 6381.5 5885.7 5991.1 6020.8 6120.7 6126.4 6844.8 7089.7 7117.2 7124.6 7155.4 7204.8 7307.0 7308.2 7371.7 7376.9 4849.0 5339.1 5562.6 5565.9 5578.5 6216.4 6340.3 6368.4 6431.1 6431.5 5568.1 5941.7 5975.5 5996.6 6036.8 5834.9 5927.5 5985.7 6014.5 6049.2 5942.3 6045.3 6061.0 6091.4 6100.5 5247.9 5381.0 5389.9 5391.6 5402.6 5464.9 5487.5 5525.8 5528.0 5538.9 22:28:46 INFO - 2015-11-13 22:28:46,767 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-11-13 22:28:46,767 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4710.90 Median:5477.75 stddev:1472.13 (26.9%) stddev-sans-first:1437.88 22:28:46 INFO - 2015-11-13 22:28:46,767 DEBUG : BROWSER_OUTPUT: Values: 261.4 265.9 266.7 268.6 278.1 5319.8 5355.1 5503.8 5507.7 5507.8 5227.8 5377.9 5394.9 5396.4 5401.6 4082.3 4109.6 4114.1 4132.7 4164.2 4131.3 4134.7 4136.4 4145.5 4145.9 3886.1 4088.1 4095.2 4098.0 4103.9 3996.5 4041.1 4045.0 4049.1 4074.2 3454.8 3456.3 3459.6 3461.8 3464.9 5083.8 5244.0 5258.8 5260.6 5285.1 4432.2 4465.6 4471.6 4475.3 4486.2 5603.6 5604.6 5613.7 5628.7 5629.4 3632.1 3634.8 3635.0 3640.6 3685.8 5696.3 5812.6 5873.6 5886.0 5937.9 3799.4 3803.5 3805.5 3808.7 3812.1 3795.0 3872.5 3883.4 3883.8 3890.4 4489.7 4508.8 4510.4 4517.9 4521.2 5294.5 5410.8 5474.9 5609.0 5615.8 1349.5 1358.1 1375.9 1379.2 1380.4 833.8 848.3 850.6 864.8 892.1 5425.0 5470.3 5476.0 5479.5 5497.5 5891.2 5893.6 5893.8 5904.5 5962.3 5406.6 5473.9 5488.8 5492.2 5504.1 3091.7 3146.8 3162.4 3197.0 3212.6 6132.1 6140.6 6140.8 6143.1 6149.4 6048.8 6061.1 6062.5 6065.4 6099.6 5926.5 6135.4 6136.0 6180.1 6188.2 5916.1 5938.9 5949.2 5960.9 5976.2 5795.1 5802.7 5822.7 5831.7 5876.9 6034.0 6116.8 6126.1 6128.5 6134.0 3708.4 3793.0 3828.5 3834.6 3844.3 5618.6 5866.8 5867.4 5890.8 5895.0 5457.7 5571.5 5678.7 5717.4 5725.5 5707.4 5719.1 5720.1 5720.6 5733.9 5557.0 5573.7 5576.3 5580.1 5581.7 5494.6 5689.5 5689.9 5691.5 5700.7 5596.4 5598.1 5598.9 5606.3 5616.6 22:28:46 INFO - 2015-11-13 22:28:46,768 DEBUG : BROWSER_OUTPUT: 22:28:46 INFO - 2015-11-13 22:28:46,769 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11649.17 Median:3212.36 stddev:14092.23 (438.7%) stddev-sans-first:14107.16 22:28:46 INFO - 2015-11-13 22:28:46,769 DEBUG : BROWSER_OUTPUT: Values: 559.5 604.1 631.2 632.3 640.9 11512.8 11733.2 11809.6 11827.3 11888.7 9672.9 9761.3 9869.3 11242.3 11242.9 600.1 605.4 758.5 763.7 767.9 725.9 744.5 761.0 773.1 776.7 776.5 779.5 784.3 792.0 795.5 780.8 781.8 783.0 783.3 794.8 576.8 581.3 584.0 584.1 594.6 11621.1 11763.6 11867.6 11921.5 11982.1 8846.5 9333.0 9403.8 9685.6 10446.8 7743.4 8127.2 8135.3 8177.1 8179.1 2694.6 2791.9 2913.2 2921.7 2940.0 40223.0 40481.8 40897.2 41113.4 41119.4 7687.4 7705.5 7721.2 7964.4 8135.0 16091.8 16092.8 16139.4 16152.2 16276.7 5576.8 5607.4 5791.2 5840.6 5855.3 2989.5 3048.6 3142.0 3164.2 3174.7 2390.3 2471.7 2472.4 2475.5 2475.7 343.5 351.0 361.0 363.9 364.8 318.9 459.2 475.6 476.4 502.3 6338.0 6864.9 6930.0 6961.9 7019.1 380.4 393.2 421.5 428.4 509.7 3215.5 3259.1 3569.5 3620.7 3642.3 50392.5 50623.2 51321.0 51361.5 51836.2 44777.6 45122.5 45227.8 45388.5 45522.8 39418.4 40156.0 40251.4 40721.8 40745.6 7110.6 7113.8 7124.5 7190.3 7202.9 29067.6 29405.3 29917.7 29938.4 30725.8 39437.0 40237.4 40544.2 40552.2 40612.6 6578.1 6652.9 6672.8 6790.6 7028.8 9055.5 9072.8 9282.5 9486.9 9929.3 8908.8 8998.1 9003.7 9250.1 9832.9 8875.8 8933.2 8934.0 9126.6 9510.9 8819.7 8955.1 9113.1 9153.1 9502.3 7612.3 7827.5 7857.3 7881.8 8163.7 7315.7 7974.6 8051.8 8313.8 8316.9 22:28:46 INFO - 2015-11-13 22:28:46,769 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:28:46 INFO - 2015-11-13 22:28:46,769 DEBUG : BROWSER_OUTPUT: 22:28:47 INFO - 2015-11-13 22:28:47,424 INFO : Browser exited with error code: 0 22:28:47 INFO - 2015-11-13 22:28:47,456 INFO : Completed test dromaeo_css (00:18:33) 22:28:47 INFO - 2015-11-13 22:28:47,456 INFO : Starting test kraken 22:28:47 INFO - 2015-11-13 22:28:47,456 DEBUG : operating with platform_type : mac_ 22:28:47 INFO - 2015-11-13 22:28:47,457 INFO : Initialising browser for kraken test... 22:28:47 INFO - 2015-11-13 22:28:47,471 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/tmpV6t3Xa/profile http://localhost:49264/getInfo.html 22:28:50 INFO - 2015-11-13 22:28:50,725 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:28:50 INFO - 2015-11-13 22:28:50,725 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:28:50 INFO - 2015-11-13 22:28:50,725 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:28:50 INFO - 2015-11-13 22:28:50,725 DEBUG : BROWSER_OUTPUT: __metrics 22:28:51 INFO - 2015-11-13 22:28:51,469 INFO : Browser initialized. 22:28:51 INFO - 2015-11-13 22:28:51,470 INFO : Running cycle 1/1 for kraken test... 22:28:51 INFO - 2015-11-13 22:28:51,470 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/tmpV6t3Xa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:29:03 INFO - 2015-11-13 22:29:03,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 241577984 22:29:03 INFO - 2015-11-13 22:29:03,624 DEBUG : BROWSER_OUTPUT: 22:29:06 INFO - 2015-11-13 22:29:06,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 22:29:07 INFO - 2015-11-13 22:29:07,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 259145728 22:29:07 INFO - 2015-11-13 22:29:07,134 DEBUG : BROWSER_OUTPUT: 22:29:10 INFO - 2015-11-13 22:29:10,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 22:29:10 INFO - 2015-11-13 22:29:10,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 267169792 22:29:10 INFO - 2015-11-13 22:29:10,782 DEBUG : BROWSER_OUTPUT: 22:29:14 INFO - 2015-11-13 22:29:14,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 22:29:14 INFO - 2015-11-13 22:29:14,658 DEBUG : BROWSER_OUTPUT: RSS: Main: 266567680 22:29:14 INFO - 2015-11-13 22:29:14,658 DEBUG : BROWSER_OUTPUT: 22:29:16 INFO - 2015-11-13 22:29:16,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 22:29:17 INFO - 2015-11-13 22:29:17,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 266878976 22:29:17 INFO - 2015-11-13 22:29:17,451 DEBUG : BROWSER_OUTPUT: 22:29:19 INFO - 2015-11-13 22:29:19,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:29:20 INFO - 2015-11-13 22:29:20,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 267657216 22:29:20 INFO - 2015-11-13 22:29:20,434 DEBUG : BROWSER_OUTPUT: 22:29:23 INFO - 2015-11-13 22:29:23,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 22:29:24 INFO - 2015-11-13 22:29:24,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 265183232 22:29:24 INFO - 2015-11-13 22:29:24,518 DEBUG : BROWSER_OUTPUT: 22:29:28 INFO - 2015-11-13 22:29:28,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 22:29:28 INFO - 2015-11-13 22:29:28,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 265781248 22:29:28 INFO - 2015-11-13 22:29:28,722 DEBUG : BROWSER_OUTPUT: 22:29:31 INFO - 2015-11-13 22:29:31,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 22:29:32 INFO - 2015-11-13 22:29:32,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 267038720 22:29:32 INFO - 2015-11-13 22:29:32,591 DEBUG : BROWSER_OUTPUT: 22:29:34 INFO - 2015-11-13 22:29:34,329 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:29:34 INFO - 2015-11-13 22:29:34,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 267857920 22:29:34 INFO - 2015-11-13 22:29:34,908 DEBUG : BROWSER_OUTPUT: 22:29:36 INFO - 2015-11-13 22:29:36,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:29:37 INFO - 2015-11-13 22:29:37,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 267608064 22:29:37 INFO - 2015-11-13 22:29:37,551 DEBUG : BROWSER_OUTPUT: 22:29:39 INFO - 2015-11-13 22:29:39,912 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:29:40 INFO - 2015-11-13 22:29:40,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 267980800 22:29:40 INFO - 2015-11-13 22:29:40,517 DEBUG : BROWSER_OUTPUT: 22:29:43 INFO - 2015-11-13 22:29:43,498 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:29:44 INFO - 2015-11-13 22:29:44,093 DEBUG : BROWSER_OUTPUT: RSS: Main: 267165696 22:29:44 INFO - 2015-11-13 22:29:44,093 DEBUG : BROWSER_OUTPUT: 22:29:47 INFO - 2015-11-13 22:29:47,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:29:47 INFO - 2015-11-13 22:29:47,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 268017664 22:29:47 INFO - 2015-11-13 22:29:47,707 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,622 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 22:29:49 INFO - 2015-11-13 22:29:49,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 267337728 22:29:49 INFO - 2015-11-13 22:29:49,878 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,878 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:29:49 INFO - 2015-11-13 22:29:49,878 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:29:49 INFO - 2015-11-13 22:29:49,878 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:29:49 INFO - 2015-11-13 22:29:49,878 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:29:49 INFO - 2015-11-13 22:29:49,878 DEBUG : BROWSER_OUTPUT: |0;ai-astar;129;122;135;135;135;146;139;137;135;129 22:29:49 INFO - 2015-11-13 22:29:49,878 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;182;161;187;206;165;188;179;159;195;159 22:29:49 INFO - 2015-11-13 22:29:49,878 DEBUG : BROWSER_OUTPUT: |2;audio-dft;197;204;203;202;202;202;201;201;202;194 22:29:49 INFO - 2015-11-13 22:29:49,879 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;91;101;144;81;84;86;88;125;84 22:29:49 INFO - 2015-11-13 22:29:49,879 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;103;105;153;107;108;109;151;109;110;161 22:29:49 INFO - 2015-11-13 22:29:49,879 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;149;143;143;149;149;150;148;150;142;142 22:29:49 INFO - 2015-11-13 22:29:49,879 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;156;156;156;157;156;156;156;157;157;156 22:29:49 INFO - 2015-11-13 22:29:49,879 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;118;140;122;128;118;118;123;123;122;128 22:29:49 INFO - 2015-11-13 22:29:49,879 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;73;73;77;78;77;77;84;76;76 22:29:49 INFO - 2015-11-13 22:29:49,879 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;81;85;85;82;84;85;84;85;85 22:29:49 INFO - 2015-11-13 22:29:49,879 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;103;107;107;109;107;108;108;111;107;110 22:29:49 INFO - 2015-11-13 22:29:49,879 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;166;174;163;156;156;169;156;157;159;165 22:29:49 INFO - 2015-11-13 22:29:49,880 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;190;194;193;189;187;190;199;192;188;171 22:29:49 INFO - 2015-11-13 22:29:49,880 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;81;85;89;95;87;89;86;88;91;92 22:29:49 INFO - 2015-11-13 22:29:49,880 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:29:49 INFO - 2015-11-13 22:29:49,880 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:29:49 INFO - 2015-11-13 22:29:49,880 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,745 22:29:49 INFO - 2015-11-13 22:29:49,880 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:29:49 INFO - 2015-11-13 22:29:49,880 DEBUG : BROWSER_OUTPUT: __startTimestamp1447482589876__endTimestamp 22:29:49 INFO - 2015-11-13 22:29:49,880 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,882 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:29:49 INFO - 2015-11-13 22:29:49,882 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:29:49 INFO - 2015-11-13 22:29:49,882 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,883 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:134.20 Median:135.00 stddev:6.46 (4.8%) stddev-sans-first:6.57 22:29:49 INFO - 2015-11-13 22:29:49,883 DEBUG : BROWSER_OUTPUT: Values: 129.0 122.0 135.0 135.0 135.0 146.0 139.0 137.0 135.0 129.0 22:29:49 INFO - 2015-11-13 22:29:49,884 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,884 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:178.10 Median:184.50 stddev:16.50 (8.9%) stddev-sans-first:17.44 22:29:49 INFO - 2015-11-13 22:29:49,884 DEBUG : BROWSER_OUTPUT: Values: 182.0 161.0 187.0 206.0 165.0 188.0 179.0 159.0 195.0 159.0 22:29:49 INFO - 2015-11-13 22:29:49,884 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,884 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:200.80 Median:202.00 stddev:3.01 (1.5%) stddev-sans-first:2.86 22:29:49 INFO - 2015-11-13 22:29:49,885 DEBUG : BROWSER_OUTPUT: Values: 197.0 204.0 203.0 202.0 202.0 202.0 201.0 201.0 202.0 194.0 22:29:49 INFO - 2015-11-13 22:29:49,885 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,885 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:96.50 Median:84.00 stddev:21.33 (25.4%) stddev-sans-first:21.87 22:29:49 INFO - 2015-11-13 22:29:49,885 DEBUG : BROWSER_OUTPUT: Values: 81.0 91.0 101.0 144.0 81.0 84.0 86.0 88.0 125.0 84.0 22:29:49 INFO - 2015-11-13 22:29:49,885 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,886 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:121.60 Median:109.50 stddev:23.27 (21.3%) stddev-sans-first:23.69 22:29:49 INFO - 2015-11-13 22:29:49,886 DEBUG : BROWSER_OUTPUT: Values: 103.0 105.0 153.0 107.0 108.0 109.0 151.0 109.0 110.0 161.0 22:29:49 INFO - 2015-11-13 22:29:49,886 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,886 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:146.50 Median:149.00 stddev:3.50 (2.4%) stddev-sans-first:3.60 22:29:49 INFO - 2015-11-13 22:29:49,886 DEBUG : BROWSER_OUTPUT: Values: 149.0 143.0 143.0 149.0 149.0 150.0 148.0 150.0 142.0 142.0 22:29:49 INFO - 2015-11-13 22:29:49,887 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,887 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:156.30 Median:156.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 22:29:49 INFO - 2015-11-13 22:29:49,887 DEBUG : BROWSER_OUTPUT: Values: 156.0 156.0 156.0 157.0 156.0 156.0 156.0 157.0 157.0 156.0 22:29:49 INFO - 2015-11-13 22:29:49,887 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,887 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:124.00 Median:123.00 stddev:6.72 (5.5%) stddev-sans-first:6.76 22:29:49 INFO - 2015-11-13 22:29:49,888 DEBUG : BROWSER_OUTPUT: Values: 118.0 140.0 122.0 128.0 118.0 118.0 123.0 123.0 122.0 128.0 22:29:49 INFO - 2015-11-13 22:29:49,889 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,889 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.90 Median:77.00 stddev:4.12 (5.4%) stddev-sans-first:3.23 22:29:49 INFO - 2015-11-13 22:29:49,889 DEBUG : BROWSER_OUTPUT: Values: 68.0 73.0 73.0 77.0 78.0 77.0 77.0 84.0 76.0 76.0 22:29:49 INFO - 2015-11-13 22:29:49,889 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,889 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:83.30 Median:85.00 stddev:2.63 (3.1%) stddev-sans-first:1.50 22:29:49 INFO - 2015-11-13 22:29:49,890 DEBUG : BROWSER_OUTPUT: Values: 77.0 81.0 85.0 85.0 82.0 84.0 85.0 84.0 85.0 85.0 22:29:49 INFO - 2015-11-13 22:29:49,890 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,890 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:107.70 Median:108.00 stddev:2.16 (2.0%) stddev-sans-first:1.48 22:29:49 INFO - 2015-11-13 22:29:49,890 DEBUG : BROWSER_OUTPUT: Values: 103.0 107.0 107.0 109.0 107.0 108.0 108.0 111.0 107.0 110.0 22:29:49 INFO - 2015-11-13 22:29:49,890 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,890 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:162.10 Median:164.00 stddev:6.33 (3.9%) stddev-sans-first:6.56 22:29:49 INFO - 2015-11-13 22:29:49,891 DEBUG : BROWSER_OUTPUT: Values: 166.0 174.0 163.0 156.0 156.0 169.0 156.0 157.0 159.0 165.0 22:29:49 INFO - 2015-11-13 22:29:49,891 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,891 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.30 Median:191.00 stddev:7.30 (3.8%) stddev-sans-first:7.74 22:29:49 INFO - 2015-11-13 22:29:49,891 DEBUG : BROWSER_OUTPUT: Values: 190.0 194.0 193.0 189.0 187.0 190.0 199.0 192.0 188.0 171.0 22:29:49 INFO - 2015-11-13 22:29:49,891 DEBUG : BROWSER_OUTPUT: 22:29:49 INFO - 2015-11-13 22:29:49,891 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:88.30 Median:89.00 stddev:3.92 (4.4%) stddev-sans-first:3.14 22:29:49 INFO - 2015-11-13 22:29:49,892 DEBUG : BROWSER_OUTPUT: Values: 81.0 85.0 89.0 95.0 87.0 89.0 86.0 88.0 91.0 92.0 22:29:49 INFO - 2015-11-13 22:29:49,892 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:29:49 INFO - 2015-11-13 22:29:49,892 DEBUG : BROWSER_OUTPUT: 22:29:50 INFO - 2015-11-13 22:29:50,590 INFO : Browser exited with error code: 0 22:29:50 INFO - 2015-11-13 22:29:50,644 INFO : Completed test kraken (00:01:03) 22:29:50 INFO - 2015-11-13 22:29:50,644 INFO : Starting test v8_7 22:29:50 INFO - 2015-11-13 22:29:50,645 DEBUG : operating with platform_type : mac_ 22:29:50 INFO - 2015-11-13 22:29:50,645 INFO : Initialising browser for v8_7 test... 22:29:50 INFO - 2015-11-13 22:29:50,659 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/tmpWRf_8q/profile http://localhost:49264/getInfo.html 22:29:53 INFO - 2015-11-13 22:29:53,796 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:29:53 INFO - 2015-11-13 22:29:53,797 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:29:53 INFO - 2015-11-13 22:29:53,797 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:29:53 INFO - 2015-11-13 22:29:53,797 DEBUG : BROWSER_OUTPUT: __metrics 22:29:54 INFO - 2015-11-13 22:29:54,482 INFO : Browser initialized. 22:29:54 INFO - 2015-11-13 22:29:54,483 INFO : Running cycle 1/1 for v8_7 test... 22:29:54 INFO - 2015-11-13 22:29:54,483 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/tmpWRf_8q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:30:06 INFO - 2015-11-13 22:30:06,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 239931392 22:30:06 INFO - 2015-11-13 22:30:06,627 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 22:30:29 INFO - 2015-11-13 22:30:29,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 257564672 22:30:29 INFO - 2015-11-13 22:30:29,486 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,486 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:30:29 INFO - 2015-11-13 22:30:29,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:30:29 INFO - 2015-11-13 22:30:29,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:30:29 INFO - 2015-11-13 22:30:29,486 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:30:29 INFO - 2015-11-13 22:30:29,487 DEBUG : BROWSER_OUTPUT: |0;Richards;878.7346221441124 22:30:29 INFO - 2015-11-13 22:30:29,487 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;232.18017181332715 22:30:29 INFO - 2015-11-13 22:30:29,487 DEBUG : BROWSER_OUTPUT: |2;Encrypt;373.13432835820896 22:30:29 INFO - 2015-11-13 22:30:29,487 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6890.41095890411 22:30:29 INFO - 2015-11-13 22:30:29,487 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1313.6482939632547 22:30:29 INFO - 2015-11-13 22:30:29,488 DEBUG : BROWSER_OUTPUT: |5;Earley;930.2325581395348 22:30:29 INFO - 2015-11-13 22:30:29,488 DEBUG : BROWSER_OUTPUT: |6;Boyer;15348.484848484848 22:30:29 INFO - 2015-11-13 22:30:29,488 DEBUG : BROWSER_OUTPUT: |7;RegExp;34586.206896551725 22:30:29 INFO - 2015-11-13 22:30:29,488 DEBUG : BROWSER_OUTPUT: |8;Splay;801.924619085806 22:30:29 INFO - 2015-11-13 22:30:29,488 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6777.027027027027 22:30:29 INFO - 2015-11-13 22:30:29,489 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:30:29 INFO - 2015-11-13 22:30:29,489 DEBUG : BROWSER_OUTPUT: __startTimestamp1447482629485__endTimestamp 22:30:29 INFO - 2015-11-13 22:30:29,489 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,489 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:30:29 INFO - 2015-11-13 22:30:29,489 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:30:29 INFO - 2015-11-13 22:30:29,489 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,489 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:878.73 Median:878.73 stddev:0.00 (0.0%) 22:30:29 INFO - 2015-11-13 22:30:29,490 DEBUG : BROWSER_OUTPUT: Values: 878.7 22:30:29 INFO - 2015-11-13 22:30:29,490 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,490 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:232.18 Median:232.18 stddev:0.00 (0.0%) 22:30:29 INFO - 2015-11-13 22:30:29,490 DEBUG : BROWSER_OUTPUT: Values: 232.2 22:30:29 INFO - 2015-11-13 22:30:29,490 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,491 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:373.13 Median:373.13 stddev:0.00 (0.0%) 22:30:29 INFO - 2015-11-13 22:30:29,491 DEBUG : BROWSER_OUTPUT: Values: 373.1 22:30:29 INFO - 2015-11-13 22:30:29,491 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,493 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6890.41 Median:6890.41 stddev:0.00 (0.0%) 22:30:29 INFO - 2015-11-13 22:30:29,493 DEBUG : BROWSER_OUTPUT: Values: 6890.4 22:30:29 INFO - 2015-11-13 22:30:29,493 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,493 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1313.65 Median:1313.65 stddev:0.00 (0.0%) 22:30:29 INFO - 2015-11-13 22:30:29,493 DEBUG : BROWSER_OUTPUT: Values: 1313.6 22:30:29 INFO - 2015-11-13 22:30:29,493 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,493 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:930.23 Median:930.23 stddev:0.00 (0.0%) 22:30:29 INFO - 2015-11-13 22:30:29,493 DEBUG : BROWSER_OUTPUT: Values: 930.2 22:30:29 INFO - 2015-11-13 22:30:29,493 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,494 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15348.48 Median:15348.48 stddev:0.00 (0.0%) 22:30:29 INFO - 2015-11-13 22:30:29,494 DEBUG : BROWSER_OUTPUT: Values: 15348.5 22:30:29 INFO - 2015-11-13 22:30:29,494 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,494 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34586.21 Median:34586.21 stddev:0.00 (0.0%) 22:30:29 INFO - 2015-11-13 22:30:29,494 DEBUG : BROWSER_OUTPUT: Values: 34586.2 22:30:29 INFO - 2015-11-13 22:30:29,494 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,494 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 22:30:29 INFO - 2015-11-13 22:30:29,494 DEBUG : BROWSER_OUTPUT: Values: 801.9 22:30:29 INFO - 2015-11-13 22:30:29,495 DEBUG : BROWSER_OUTPUT: 22:30:29 INFO - 2015-11-13 22:30:29,495 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6777.03 Median:6777.03 stddev:0.00 (0.0%) 22:30:29 INFO - 2015-11-13 22:30:29,495 DEBUG : BROWSER_OUTPUT: Values: 6777.0 22:30:29 INFO - 2015-11-13 22:30:29,495 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:30:29 INFO - 2015-11-13 22:30:29,495 DEBUG : BROWSER_OUTPUT: 22:30:30 INFO - 2015-11-13 22:30:30,238 INFO : Browser exited with error code: 0 22:30:30 INFO - 2015-11-13 22:30:30,261 INFO : Completed test v8_7 (00:00:39) 22:30:30 INFO - 2015-11-13 22:30:30,450 INFO : Completed test suite (00:20:16) 22:30:30 INFO - 2015-11-13 22:30:30,450 DEBUG : Working with test: dromaeo_css 22:30:30 INFO - 2015-11-13 22:30:30,450 DEBUG : Generating results file: dromaeo_css 22:30:30 INFO - 2015-11-13 22:30:30,451 DEBUG : Working with test: kraken 22:30:30 INFO - 2015-11-13 22:30:30,451 DEBUG : Generating results file: kraken 22:30:30 INFO - 2015-11-13 22:30:30,451 INFO : javascript benchmark 22:30:30 INFO - 2015-11-13 22:30:30,452 DEBUG : Working with test: v8_7 22:30:30 INFO - 2015-11-13 22:30:30,452 DEBUG : Generating results file: v8_7 22:30:30 INFO - 2015-11-13 22:30:30,452 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:30:30 INFO - 2015-11-13 22:30:30,583 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 22:30:30 INFO - 2015-11-13 22:30:30,583 DEBUG : process_Request line: dromaeo_css 5641.88 graph.html#tests=[[72,64,57]] 22:30:30 INFO - 2015-11-13 22:30:30,584 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:30:30 INFO - 2015-11-13 22:30:30,692 DEBUG : process_Request line: kraken 1864.60 graph.html#tests=[[232,64,57]] 22:30:30 INFO - 2015-11-13 22:30:30,692 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:30:30 INFO - 2015-11-13 22:30:30,815 DEBUG : process_Request line: v8_7 14247.91 graph.html#tests=[[230,64,57]] 22:30:30 INFO - 2015-11-13 22:30:30,816 INFO : javascript benchmark 22:30:30 INFO - 2015-11-13 22:30:30,818 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [282.30834455583823, 285.4234446418235, 286.48289836844486, 289.2277618757916, 290.08333665616647, 12467.314297713621, 13962.650933726649, 14450.710985780292, 14481.493147739831, 15041.172735499544, 14713.117212967203, 14800.0, 15006.924965375158, 15011.924940375282, 15169.317380717866, 4490.304002879542, 4516.796744146522, 4646.0, 4655.231886738684, 4708.223143181371, 4591.196540605398, 4643.8142474300985, 4645.512221216757, 4650.116477869194, 4707.7175369477945, 2813.0, 2852.614896988901, 4670.065986802653, 4671.929921051187, 4727.810887564493, 4006.479157709494, 4106.897327566835, 4122.670186385082, 4128.6284234419045, 4131.153113611717, 3501.212227248874, 3501.824908754552, 3506.158521954738, 3506.719462443024, 3534.7348948828685, 10480.213983951235, 11070.446477676083, 11077.556897724082, 11078.612248571262, 11079.335239885633, 1615.240836806699, 1648.5301689018693, 1652.5785924589152, 1678.5887457572974, 1709.6837085139289, 8015.158408367154, 8220.547869867154, 8283.0, 8398.538080405575, 8428.072911979678, 1285.3573213393304, 1315.5790147152916, 1323.5764555342294, 1331.0815537279245, 1336.565616174747, 45038.54961450409, 45585.316220256726, 45747.999999999665, 46088.769556152, 46368.76815615934, 5487.945120548823, 5513.365962914236, 5593.972030139823, 5601.803936862272, 5659.377468478464, 6302.180716506825, 6412.294647588761, 6421.325760795143, 6422.903656445157, 6424.357564243538, 4611.377464042312, 4632.72203667781, 4643.349931009661, 4698.882527936829, 4715.834945776881, 4963.528464795839, 4970.751462426936, 5046.243063540425, 5083.644144909821, 5088.262201980692, 2476.7151777545814, 2521.8360806547885, 2532.962005569918, 2533.1640558615613, 2581.2127301172945, 893.1871996483169, 897.3763234551924, 898.2499612823366, 904.2268860124499, 951.6907005223192, 359.53799367812235, 362.98003609801714, 369.5030184402029, 391.15120189189525, 392.6995848176148, 8621.267192288726, 9236.7690807729, 9692.515374231401, 10012.349197302152, 10170.491475426199, 386.0541672901403, 394.0444422275969, 394.40248024243294, 395.7150851386997, 402.523010232875, 5242.16125419931, 5332.600054995891, 5349.592683292534, 5416.0, 5422.91865622016, 398869.0, 399410.0, 407663.7700868979, 410641.0, 411144.0, 56805.431945680844, 57026.0, 57669.0, 58509.41490585125, 58810.70594646999, 389.2099038950934, 392.90766669832567, 392.9783861887624, 393.9940900886546, 394.02085816745364, 9240.537973101453, 9253.768655783659, 9254.4910029949, 9308.348415611114, 9471.28965327617, 26788.464230715665, 28013.719862801925, 28239.717602823708, 28409.43181136407, 29128.854355728086, 38111.80944095262, 38456.2308753829, 38752.41871371988, 38785.0, 38883.416748749354, 5200.193969934666, 5224.111900976767, 5311.804843910089, 5312.468753124656, 5321.201819727072, 9913.355631883904, 10041.548130334006, 10051.0, 10076.042775936274, 10158.492075396052, 8574.571271436278, 8668.696595619123, 8701.47791132534, 8746.562671866508, 8790.912090879265, 7031.402330801735, 7512.399008079231, 8199.0, 8347.749567512985, 8720.694775682821, 8539.8719019216, 8707.564621769014, 8749.212570868653, 8760.474371537728, 8760.561971901507, 5329.253904453302, 5336.839894803162, 5359.732013399393, 5404.621676482766, 5416.187571864094, 8548.444351117158, 8583.570821458778, 8923.687670931486, 8940.776480588038, 9001.279897608307], "dojo.html": [2654.5221860065185, 2706.526357887369, 2723.428080103178, 2724.8637568121594, 2787.1220565521858, 4497.1455423469515, 4533.478649955252, 4574.2223821950265, 4582.335561343607, 4627.907441851161, 4403.075354175619, 4488.214562451566, 4519.299508576176, 4522.0, 4586.8394606188795, 4160.56314087021, 4239.321708526636, 4270.786460676969, 4327.480702315726, 4354.303311470166, 4177.979110104445, 4304.203722311367, 4315.978420107895, 4336.21948049351, 4376.212281789277, 4079.9184016319805, 4147.751134931914, 4154.169166166779, 4245.257080010986, 4314.417553630266, 4091.2226676931587, 4135.29699951009, 4192.434021407102, 4201.34879093741, 4220.894477638053, 4124.505059392892, 4201.68487363449, 4210.59999300066, 4239.894002649928, 4286.57134286572, 4353.564643535653, 4364.2798938175165, 4372.846950356754, 4540.659450541222, 4543.8182472701055, 4848.733319667417, 4903.53416425439, 4905.901881962376, 4917.164082106015, 4946.826861059882, 4876.878078048042, 4915.115279249733, 4955.925661115086, 4979.7759100840185, 4990.30135780991, 4370.2133615949115, 4433.135538570013, 4475.194464996332, 4489.124620698933, 4662.160811054009, 5015.322931404214, 5086.0845047891, 5089.541941225233, 5104.05574968632, 5154.793808247703, 4791.065742180311, 4822.565969062801, 4859.878503037452, 4885.267209918541, 4887.804487820447, 4501.3022981437925, 4753.47711751707, 4822.132016237111, 4878.682885612424, 4901.313816065754, 4807.4471435785335, 4836.008618233253, 4852.223644216909, 4917.704937703677, 4924.4583095859425, 4693.906121877543, 4818.036392721469, 4838.854834354975, 4864.73243971585, 4947.035328110984, 3699.5560532736245, 3709.888703338904, 3769.981150094287, 3790.4124860646643, 3798.962010379916, 3397.6262611112757, 3410.9658903411146, 3453.4129198036394, 3465.2203254268093, 3493.318802833423, 4494.595486406239, 4529.38853254813, 4579.610733087658, 4706.317583950308, 4766.285057241442, 4833.347498087784, 4879.39007624047, 4881.95118048822, 4905.607551395879, 4918.163912134874, 4603.930941035887, 4644.16405047088, 4652.32541281519, 4687.789049492712, 4749.121412538691, 4175.0, 4178.143480586473, 4280.315149576053, 4288.849890253826, 4319.136172765459, 5067.8986420271385, 5078.263651770547, 5125.0, 5151.974240128776, 5159.871003224949, 4940.481249468754, 4941.481144479778, 4967.577755890645, 4986.252062190701, 5010.824621138243, 4842.806287748451, 4882.145624515624, 4993.80024799004, 5082.618803589671, 5130.307408499804, 4821.368881616098, 4823.517648235148, 4912.459629440687, 4931.186354251508, 4955.776990035529, 4895.388076490439, 4906.607471402208, 4953.653244272867, 4961.454240033666, 4975.203967365204, 4479.910401792011, 4648.860534183845, 4686.437627484587, 4753.857384278477, 4761.047790441995, 4626.167289887852, 4713.693609915482, 4747.762611869462, 4774.21225497789, 4786.641001924939, 4632.5830675239395, 4683.742394168354, 4712.59942904857, 4743.169945259497, 4795.448523419851, 4522.683412161117, 4711.104890070876, 4815.349927759848, 4850.854474365775, 4892.730899800546, 4608.170529304623, 4638.83764068256, 4648.418947631546, 4670.252759558454, 4677.204875171297], "mootools.html": [1473.1676602719456, 1486.821581410231, 1518.559617710864, 1530.0054964273222, 1558.2987655554996, 5809.070548712207, 5851.912221316684, 6487.837804054901, 6943.0, 6961.582305061694, 6200.255969283692, 6221.937780622193, 6480.060391243267, 6481.222253329607, 6498.350164983499, 1842.622262436204, 1847.8336949674526, 1871.831535161835, 1875.5779949511318, 1879.7274395212687, 1830.7528483654735, 1883.3408307092477, 1891.5838515526632, 1907.7806052304024, 1917.2906024770784, 1860.5162657708959, 1866.5426970392205, 1871.2795573704154, 1894.4222012286248, 1895.516643255968, 1841.3003058837623, 1873.316239572553, 1877.7840548336978, 1897.6299621573799, 1898.876573022756, 1821.5628249220224, 1836.9816301837077, 1840.6778813707547, 1845.8800177988387, 1908.895010774407, 6554.410103090745, 6620.966895165541, 6666.799996000128, 6694.899576506356, 6708.12794336738, 3975.7614543127215, 3992.6007399260134, 4009.799510024516, 4062.1875624875142, 4076.9388459173138, 2363.7518060603734, 2487.7761001509953, 2531.658226139466, 2535.9239222823344, 2539.898404063835, 746.7685017644548, 762.0893032825776, 762.3824701991405, 764.3121190928154, 770.3990887108065, 8895.866562001574, 8898.4660920345, 8925.464472131627, 9030.458172509605, 9063.50150741709, 3433.828308584561, 3457.9827100864336, 3501.142220156078, 3573.535440392732, 3617.439296908983, 7317.780466586011, 7325.963370183115, 7377.557346559223, 7425.517341372793, 7444.702211911571, 3919.098607320332, 3966.5835087315995, 3969.622885825842, 3970.82131304092, 3983.701222408331, 3110.751139908802, 3168.683131686813, 3592.2995015971633, 3625.8549658013912, 3663.816809159585, 2856.1003283965483, 2955.6453225612636, 2962.066948911086, 3007.3985202959057, 3019.4866872631706, 861.0227391910227, 873.214107303432, 874.0429229993148, 874.6545114679793, 875.382855087162, 853.9615717292737, 859.4155973937658, 869.5000374784398, 885.3536918049859, 918.3433844801, 6296.087067375205, 6423.807285781434, 6494.545381823227, 6516.315786842408, 6537.869242615121, 958.4776296918196, 976.0776066616979, 991.9008099190023, 1011.2516737614112, 1016.6340117557673, 4896.681715688469, 4978.253262010655, 4996.775145118479, 5094.465081166424, 5132.923006154911, 7978.481398709066, 8043.919560804434, 8132.959335203286, 8201.22088401601, 8224.712135075244, 7899.091604465445, 7903.0, 8013.679452821939, 8094.190580941859, 8114.269715725613, 6286.654234017173, 6348.968255158787, 6364.64994425311, 6373.617582945131, 6381.489480841522, 5885.676287804212, 5991.131285963424, 6020.789272375446, 6120.693965301806, 6126.417990290915, 6844.794656160323, 7089.680964356719, 7117.181524124792, 7124.5725256484775, 7155.391791697556, 7204.783856484314, 7306.96346518264, 7308.1595616502655, 7371.705131794668, 7376.889346659697, 4848.9757551212015, 5339.119045357628, 5562.638428502134, 5565.860853478695, 5578.525825304894, 6216.44052035319, 6340.302566717565, 6368.426841584094, 6431.099646049463, 6431.453326467303, 5568.1091025435735, 5941.702914854326, 5975.462208401264, 5996.610220335664, 6036.849078773066, 5834.94165058344, 5927.496162826035, 5985.700714964321, 6014.548908831767, 6049.153118563493, 5942.346341902474, 6045.335013148638, 6061.030235162353, 6091.390860914051, 6100.481459076028, 5247.947520524898, 5381.0, 5389.946100539101, 5391.649542779707, 5402.621816472966, 5464.890702186013, 5487.451254874641, 5525.751341189576, 5528.032594296063, 5538.944610554004], "ext.html": [469.91776439123146, 477.7873846138468, 479.0490875611912, 498.7780437705222, 510.041122689344, 32343.0, 33597.0, 33673.32653346938, 33702.0, 33708.0, 36357.27285454289, 36652.63347366526, 36661.816690916574, 36666.26667466649, 36717.44923826145, 7815.609219539015, 7980.840383192332, 7990.480618759762, 8017.078036025873, 8037.23646253605, 7765.06819181699, 7899.052113746358, 7900.130985591609, 7909.248621380988, 7914.564698941556, 6972.51192416531, 6974.337437943387, 7003.47473939454, 7004.0, 7031.296870312979, 7824.765257042298, 7897.0, 7901.48640338379, 7912.564808935506, 7914.881276780853, 7670.8465830683635, 7800.336971357441, 7819.804504887424, 7823.921760782377, 7836.098848632366, 33618.310535157376, 34048.31903361944, 34062.48906266408, 34083.14792130192, 34089.0, 2385.2248019393764, 2510.585753350695, 2751.312171957011, 2773.9583906241423, 2978.7021297870256, 23383.88308058466, 23521.29436116919, 23552.0, 23931.760682393127, 23954.16160434394, 2063.123172651632, 2064.5457999240293, 2068.503559145809, 2083.468715477559, 2117.142557264295, 224670.0, 227367.0, 227915.0, 228626.0, 229046.99999999834, 42756.358654620206, 43769.0, 47663.0, 48041.27938080932, 52834.47165528373, 49501.75249123731, 50378.748106259234, 50673.49326506688, 50684.0, 51291.48708512942, 13018.349082546025, 13340.0, 13514.189148650916, 13520.864791352158, 13526.053176277566, 10078.798424031478, 10107.393556386492, 10218.489075546193, 10291.742706432398, 10316.535755891004, 15638.296276667577, 15820.76268855968, 16019.519414417586, 16083.195840207944, 16113.919430402773, 6727.596344219362, 6864.24493305736, 6877.0, 6888.104546409035, 6993.300669932966, 796.2555011064674, 801.9198080191934, 808.9514629122272, 864.7362554420962, 877.4954401219325, 20682.482937926674, 20997.580048398948, 21180.25869094605, 21298.25456109029, 23920.282391528282, 894.351595093552, 907.7276816955019, 927.8190752803139, 958.9664361747306, 999.8450240212778, 11407.771844563229, 11516.366599837089, 11529.654110376701, 11530.942345288388, 11669.591564295379, 194670.0, 199560.0, 200692.9965350193, 200865.0, 201065.0, 40178.799106004284, 40468.595314046484, 40922.0, 41068.58931410708, 44196.55803441989, 1183.7454947186395, 1184.0764203920955, 1185.3065956415421, 1188.4948896719034, 1194.5818963362753, 22210.111595535996, 22622.773772262066, 22845.200417985954, 22859.771402285765, 22915.65626515637, 37443.43834842425, 37838.62161378351, 37851.810740946115, 37861.0, 38358.6164138355, 241396.0, 242253.0, 243036.0, 243942.0, 245015.0, 25084.0, 41083.0, 42695.786521067195, 42814.0, 42872.0, 37626.62373376341, 39082.41376379413, 39735.80132099437, 40019.599804002755, 40861.0, 32374.19064523406, 32773.836130819196, 32815.50776738303, 32848.50727239141, 32970.340593188484, 31414.68585314209, 32617.18457038498, 32851.8357408221, 33034.17414564655, 33284.1678958028, 33223.501647474826, 33708.66291337055, 34960.245376850246, 36072.81963590165, 36642.8167859159, 27564.31089222705, 28893.56659650065, 28922.0, 29064.273393164494, 29269.0, 21679.0, 22095.44761380978, 22110.557788844453, 22133.225337113123, 22276.220332288292], "prototype.html": [261.359668811412, 265.93750468639865, 266.7066227150135, 268.56626548124785, 278.1419321393501, 5319.840404787853, 5355.0628639987945, 5503.779848806048, 5507.669539827608, 5507.807226747064, 5227.817026404076, 5377.865553361168, 5394.91907621386, 5396.379416367119, 5401.648892821964, 4082.3060079786505, 4109.6438175402045, 4114.136031433388, 4132.710710250284, 4164.208800327943, 4131.277026520362, 4134.689898257643, 4136.400221967813, 4145.54399016108, 4145.875623731293, 3886.1061955750192, 4088.080181959065, 4095.1809638072355, 4097.959020409788, 4103.938440923389, 3996.540397854255, 4041.11095558978, 4045.0089728016824, 4049.0564529025937, 4074.2055299216663, 3454.758166928316, 3456.343294773985, 3459.5502584664086, 3461.8442170102408, 3464.8960531184107, 5083.822066227701, 5243.973780131075, 5258.763355649005, 5260.631755777097, 5285.07511185541, 4432.180046691373, 4465.59809617136, 4471.575200355961, 4475.328700694922, 4486.170058539181, 5603.579731520153, 5604.635698679573, 5613.7193140342815, 5628.690422026787, 5629.352624448159, 3632.1282892105705, 3634.800085995269, 3635.0, 3640.5813331466957, 3685.7788532688123, 5696.316442026942, 5812.564057695689, 5873.559483038746, 5886.0, 5937.881242375129, 3799.3920972644246, 3803.54357477099, 3805.5052843130215, 3808.6572208500816, 3812.066043819282, 3794.962050379516, 3872.496575445174, 3883.436901649245, 3883.8446462141196, 3890.377539593708, 4489.663275254369, 4508.819647214074, 4510.368548403226, 4517.932231016537, 4521.163584736834, 5294.470552944752, 5410.83767486976, 5474.863128421742, 5609.046462101453, 5615.848751006034, 1349.5276653171509, 1358.110437663332, 1375.8624137586162, 1379.165604809076, 1380.4064252371577, 833.7873842170208, 848.2577744473585, 850.5959669157224, 864.8313578852063, 892.0588778838388, 5424.972875135678, 5470.343558772973, 5476.0, 5479.506844383945, 5497.505224529811, 5891.175235467038, 5893.616914900518, 5893.823185304448, 5904.527637788967, 5962.25471816023, 5406.6215364924865, 5473.863153421196, 5488.780448782004, 5492.203630473638, 5504.146857237135, 3091.6599174091284, 3146.7797254192446, 3162.446571849917, 3197.0249074032176, 3212.566303549038, 6132.08018797184, 6140.5701600887505, 6140.815775526741, 6143.139960405547, 6149.385061493815, 6048.758049678052, 6061.121137435047, 6062.545309101835, 6065.3934606539, 6099.603525770811, 5926.547995740985, 6135.355787642323, 6135.969320153371, 6180.134781130645, 6188.164597779422, 5916.142159386951, 5938.881222375615, 5949.167116603766, 5960.940390596039, 5976.163337132892, 5795.072788353843, 5802.6808525531505, 5822.679752613647, 5831.70841457917, 5876.941230587639, 6033.9698301508215, 6116.847078823065, 6126.142340072304, 6128.4790792783115, 6134.0, 3708.351038568294, 3792.9620703792607, 3828.4831547741815, 3834.5973672765076, 3844.2695887781233, 5618.578606604439, 5866.767978724516, 5867.354590995073, 5890.823275301748, 5895.0, 5457.69982650958, 5571.470710282517, 5678.659280443187, 5717.371089180104, 5725.484706376279, 5707.400722924033, 5719.056355701429, 5720.08478643415, 5720.628159169641, 5733.942660573508, 5557.0, 5573.665580065209, 5576.302962129734, 5580.135079062752, 5581.693006884498, 5494.560435165097, 5689.487946084872, 5689.943100569107, 5691.544676425793, 5700.657960522382, 5596.384397716167, 5598.1322894951345, 5598.888022239614, 5606.327240731139, 5616.634918730269], "yui.html": [559.5076332827113, 604.1240201707523, 631.2078341681189, 632.3328888023136, 640.9070684750715, 11512.769744605113, 11733.237339572943, 11809.641891182517, 11827.34949577773, 11888.702782430444, 9672.903270967288, 9761.267904907143, 9869.259805514597, 11242.269252498581, 11242.887571124287, 600.093858274005, 605.4429924469476, 758.4993904023332, 763.73651090374, 767.9385649148082, 725.92377800331, 744.4639859301294, 760.98858517122, 773.1186447449911, 776.6621519638946, 776.4952780692566, 779.5478622398995, 784.274546044909, 792.0178978067185, 795.5187111797337, 780.75406247032, 781.812365032391, 782.9882551761729, 783.2676447521557, 794.8171920458327, 576.766409604111, 581.3024370755111, 584.0305093544738, 584.1208980484344, 594.6283572767021, 11621.128415368881, 11763.58827441044, 11867.58463453775, 11921.523139074427, 11982.101342399355, 8846.469211847245, 9333.0, 9403.764905877408, 9685.564149613285, 10446.791064178673, 7743.380529557622, 8127.2279133482225, 8135.3491720662205, 8177.100518942971, 8179.059408168077, 2694.568868980973, 2791.860406979643, 2913.1697466222236, 2921.7370436660804, 2940.0, 40223.0, 40481.79759101215, 40897.18205635871, 41113.383299250534, 41119.38320925159, 7687.423443241779, 7705.460617756703, 7721.189275126143, 7964.362850971908, 8135.0, 16091.839081609034, 16092.75860862088, 16139.35442582307, 16152.192390380435, 16276.674466510603, 5576.832695019156, 5607.383187849333, 5791.189233507313, 5840.591158618856, 5855.297364316224, 2989.5216765317446, 3048.6036815214325, 3142.041677288449, 3164.193130751644, 3174.714275715197, 2390.2590197038626, 2471.740467250913, 2472.394263405477, 2475.504899020203, 2475.6905386826647, 343.4813431718074, 351.0259031188472, 360.9927801443956, 363.9181184233526, 364.797537366764, 318.9457792175336, 459.1559052001372, 475.59099174709723, 476.40449438202245, 502.29678450170053, 6338.0, 6864.897026544606, 6930.0, 6961.860762784716, 7019.0875186226485, 380.44075209442076, 393.21357285429144, 421.49631190726785, 428.36601829292823, 509.68144909431606, 3215.453372926608, 3259.071164718044, 3569.4824250484053, 3620.7465477416854, 3642.307961487309, 50392.4882253533, 50623.24065139026, 51321.0, 51361.48638513642, 51836.22245666318, 44777.55222447734, 45122.54877451249, 45227.77386113048, 45388.546114539095, 45522.77238613852, 39418.408723869165, 40156.0, 40251.39622905659, 40721.79639101786, 40745.592544074774, 7110.57336559808, 7113.82215444618, 7124.536905101152, 7190.316919892602, 7202.89195662076, 29067.56398654064, 29405.26486837846, 29917.70082299149, 29938.401231974804, 30725.846370768002, 39437.0, 40237.39643905285, 40544.1891162181, 40552.18895622012, 40612.59387406088, 6578.111954886029, 6652.900206497004, 6672.83317917056, 6790.558613690095, 7028.789136325919, 9055.501947392693, 9072.818543629222, 9282.489463079595, 9486.905130948879, 9929.255305851946, 8908.777280567778, 8998.055204203465, 9003.684871029482, 9250.126169882038, 9832.852507212541, 8875.822483550422, 8933.19601235892, 8934.0, 9126.556171259492, 9510.857337140087, 8819.735407937773, 8955.104489550993, 9113.134252246025, 9153.07054106639, 9502.287328450255, 7612.276833700789, 7827.491213071132, 7857.253560911704, 7881.802954926173, 8163.673453062049, 7315.670794814353, 7974.641141148546, 8051.798705032421, 8313.83372332562, 8316.916830831615]}, "summary": {"lowerIsBetter": false, "suite": 5641.87745166575, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5672.883422611056, "unit": "ms", "value": 5672.883422611056}, "dojo.html": {"lowerIsBetter": false, "filtered": 4518.08567071778, "unit": "ms", "value": 4518.08567071778}, "mootools.html": {"lowerIsBetter": false, "filtered": 3749.2146783235366, "unit": "ms", "value": 3749.2146783235366}, "ext.html": {"lowerIsBetter": false, "filtered": 15574.03508064287, "unit": "ms", "value": 15574.03508064287}, "prototype.html": {"lowerIsBetter": false, "filtered": 4213.534558860333, "unit": "ms", "value": 4213.534558860333}, "yui.html": {"lowerIsBetter": false, "filtered": 5113.909414506762, "unit": "ms", "value": 5113.909414506762}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0104.e"}, "testrun": {"date": 1447481413, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113211931", "branch": "Fx-Team", "revision": "81de57cbfed15c61062f2292cef14caf9c21d989"}}, {"talos_counters": {}, "results": {"audio-dft": [197.0, 204.0, 203.0, 202.0, 202.0, 202.0, 201.0, 201.0, 202.0, 194.0], "ai-astar": [129.0, 122.0, 135.0, 135.0, 135.0, 146.0, 139.0, 137.0, 135.0, 129.0], "imaging-gaussian-blur": [149.0, 143.0, 143.0, 149.0, 149.0, 150.0, 148.0, 150.0, 142.0, 142.0], "audio-beat-detection": [182.0, 161.0, 187.0, 206.0, 165.0, 188.0, 179.0, 159.0, 195.0, 159.0], "json-stringify-tinderbox": [77.0, 81.0, 85.0, 85.0, 82.0, 84.0, 85.0, 84.0, 85.0, 85.0], "stanford-crypto-pbkdf2": [190.0, 194.0, 193.0, 189.0, 187.0, 190.0, 199.0, 192.0, 188.0, 171.0], "json-parse-financial": [68.0, 73.0, 73.0, 77.0, 78.0, 77.0, 77.0, 84.0, 76.0, 76.0], "stanford-crypto-sha256-iterative": [81.0, 85.0, 89.0, 95.0, 87.0, 89.0, 86.0, 88.0, 91.0, 92.0], "audio-fft": [81.0, 91.0, 101.0, 144.0, 81.0, 84.0, 86.0, 88.0, 125.0, 84.0], "imaging-darkroom": [156.0, 156.0, 156.0, 157.0, 156.0, 156.0, 156.0, 157.0, 157.0, 156.0], "stanford-crypto-ccm": [166.0, 174.0, 163.0, 156.0, 156.0, 169.0, 156.0, 157.0, 159.0, 165.0], "audio-oscillator": [103.0, 105.0, 153.0, 107.0, 108.0, 109.0, 151.0, 109.0, 110.0, 161.0], "stanford-crypto-aes": [103.0, 107.0, 107.0, 109.0, 107.0, 108.0, 108.0, 111.0, 107.0, 110.0], "imaging-desaturate": [118.0, 140.0, 122.0, 128.0, 118.0, 118.0, 123.0, 123.0, 122.0, 128.0]}, "summary": {"lowerIsBetter": true, "suite": 1864.6, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 96.5, "unit": "ms", "value": 96.5}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 189.3, "unit": "ms", "value": 189.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 178.1, "unit": "ms", "value": 178.1}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 162.1, "unit": "ms", "value": 162.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 156.3, "unit": "ms", "value": 156.3}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 75.9, "unit": "ms", "value": 75.9}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 121.6, "unit": "ms", "value": 121.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 134.2, "unit": "ms", "value": 134.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 200.8, "unit": "ms", "value": 200.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 88.3, "unit": "ms", "value": 88.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 83.3, "unit": "ms", "value": 83.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 146.5, "unit": "ms", "value": 146.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 107.7, "unit": "ms", "value": 107.7}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 124.0, "unit": "ms", "value": 124.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0104.e"}, "testrun": {"date": 1447481413, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113211931", "branch": "Fx-Team", "revision": "81de57cbfed15c61062f2292cef14caf9c21d989"}}, {"talos_counters": {}, "results": {"DeltaBlue": [232.18017181332715], "Encrypt": [373.13432835820896], "NavierStokes": [6777.027027027027], "Decrypt": [6890.41095890411], "Splay": [801.924619085806], "Richards": [878.7346221441124], "RegExp": [34586.206896551725], "Earley": [930.2325581395348], "Boyer": [15348.484848484848], "RayTrace": [1313.6482939632547]}, "summary": {"lowerIsBetter": false, "suite": 14247.912473741311, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 284.77022600000004, "unit": "score", "value": 284.77022600000004}, "Encrypt": {"lowerIsBetter": false, "filtered": 713.3650800000001, "unit": "score", "value": 713.3650800000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 218.97507477567297, "unit": "score", "value": 218.97507477567297}, "Decrypt": {"lowerIsBetter": false, "filtered": 38.63064214711727, "unit": "score", "value": 38.63064214711727}, "Splay": {"lowerIsBetter": false, "filtered": 101.619277, "unit": "score", "value": 101.619277}, "RegExp": {"lowerIsBetter": false, "filtered": 26.339546360917247, "unit": "score", "value": 26.339546360917247}, "Richards": {"lowerIsBetter": false, "filtered": 40.173676000000015, "unit": "score", "value": 40.173676000000015}, "Earley": {"lowerIsBetter": false, "filtered": 716.4477249999997, "unit": "score", "value": 716.4477249999997}, "Boyer": {"lowerIsBetter": false, "filtered": 43.422071076011875, "unit": "score", "value": 43.422071076011875}, "RayTrace": {"lowerIsBetter": false, "filtered": 563.3083096903094, "unit": "score", "value": 563.3083096903094}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0104.e"}, "testrun": {"date": 1447481413, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113211931", "branch": "Fx-Team", "revision": "81de57cbfed15c61062f2292cef14caf9c21d989"}}] 22:30:30 INFO - RETURN: dromaeo_css: 5641.88 22:30:30 INFO - RETURN: kraken: 1864.60 22:30:30 INFO - RETURN: v8_7: 14247.91 22:30:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "14247.91"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1864.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5641.88"}}} 22:30:30 INFO - Return code: 0 22:30:30 INFO - # TBPL SUCCESS # 22:30:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:30:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:30:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:30:30 INFO - 2015-11-13 22:30:30.912 screenresolution[1664:11568] starting screenresolution argv=screenresolution get 22:30:30 INFO - 2015-11-13 22:30:30.915 screenresolution[1664:11568] Display 0: 1600x1200x32@60 22:30:30 INFO - 2015-11-13 22:30:30.922 screenresolution[1665:11571] starting screenresolution argv=screenresolution list 22:30:30 INFO - Available Modes on Display 0 22:30:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:30:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:30:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:30:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:30:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:30:31 INFO - Intel HD Graphics 3000: 22:30:31 INFO - Chipset Model: Intel HD Graphics 3000 22:30:31 INFO - Type: GPU 22:30:31 INFO - Bus: Built-In 22:30:31 INFO - VRAM (Total): 512 MB 22:30:31 INFO - VRAM (Dynamic, Max): 10 22:30:31 INFO - Vendor: Intel (0x8086) 22:30:31 INFO - Device ID: 0x0116 22:30:31 INFO - Revision ID: 0x0009 22:30:31 INFO - Displays: 22:30:31 INFO - Display: 22:30:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:30:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:30:31 INFO - Display Serial Number: 1600x1200 60 22:30:31 INFO - Main Display: Yes 22:30:31 INFO - Mirror: Off 22:30:31 INFO - Online: Yes 22:30:31 INFO - Rotation: Supported 22:30:31 INFO - Return code: 0 22:30:31 INFO - Running post-action listener: _resource_record_post_action 22:30:31 INFO - Running post-run listener: _resource_record_post_run 22:30:32 INFO - Total resource usage - Wall time: 1260s; CPU: 30.0%; Read bytes: 39707648; Write bytes: 692006912; Read time: 5620; Write time: 57132 22:30:32 INFO - install - Wall time: 42s; CPU: 30.0%; Read bytes: 341275136; Write bytes: 338563072; Read time: 37558; Write time: 6672 22:30:32 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 37270528; Write bytes: 343183360; Read time: 4887; Write time: 49496 22:30:32 INFO - Running post-run listener: _upload_blobber_files 22:30:32 INFO - Blob upload gear active. 22:30:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:30:32 INFO - Copying logs to upload dir... 22:30:32 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1326.349890 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2015-11-13 22:30:32.361364) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:30:32.364742) ========= 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.erwtkdXTIv/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.UVUh7qSFdo/Listeners TMPDIR=/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010636 build_url: 'https://queue.taskcluster.net/v1/task/hyVTX4usQ8yAmNRFqLrK2A/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-13 22:30:32.397256) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:30:32.397782) ========= 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.erwtkdXTIv/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.UVUh7qSFdo/Listeners TMPDIR=/var/folders/2v/n4b15wb56w9gwcvrw7gy6pq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005755 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 22:30:32.450044) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 22:30:32.450797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 22:30:32.451598) ========= ========= Total master_lag: 0.64 =========