builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0028 starttime: 1448387997.13 results: success (0) buildid: 20151124083121 builduid: 57ec50228a394e12a2ddb244727a7fda revision: d516d82f29a2636c5834c7f3c932025b8e85a8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.132098) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.132503) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.132800) ========= 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.4M6waryZ8X/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.S6ZFGohRYa/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005447 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.153030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.153350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.170884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.171209) ========= 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.4M6waryZ8X/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.S6ZFGohRYa/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005237 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.219463) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.220663) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.221041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.221337) ========= 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.4M6waryZ8X/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.S6ZFGohRYa/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-24 09:59:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.80M=0.001s 2015-11-24 09:59:57 (9.80 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116550 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.351468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.353220) ========= 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.4M6waryZ8X/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.S6ZFGohRYa/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019401 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:57.401371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 09:59:57.401727) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d516d82f29a2636c5834c7f3c932025b8e85a8ad --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 d516d82f29a2636c5834c7f3c932025b8e85a8ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4M6waryZ8X/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.S6ZFGohRYa/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-24 09:59:57,473 truncating revision to first 12 chars 2015-11-24 09:59:57,473 Setting DEBUG logging. 2015-11-24 09:59:57,474 attempt 1/10 2015-11-24 09:59:57,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d516d82f29a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 09:59:58,680 unpacking tar archive at: fx-team-d516d82f29a2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.473825 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-24 09:59:58.893774) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:58.894426) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:58.906437) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:58.906696) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 09:59:58.907089) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-24 09:59:58.907363) ========= /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.4M6waryZ8X/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.S6ZFGohRYa/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:59:59 INFO - MultiFileLogger online at 20151124 09:59:59 in /builds/slave/test 09:59:59 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 09:59:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:59:59 INFO - {'append_to_log': False, 09:59:59 INFO - 'base_work_dir': '/builds/slave/test', 09:59:59 INFO - 'blob_upload_branch': 'Fx-Team', 09:59:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:59:59 INFO - 'branch': 'Fx-Team', 09:59:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:59:59 INFO - 'config_files': ('talos/mac_config.py',), 09:59:59 INFO - 'default_actions': ('clobber', 09:59:59 INFO - 'read-buildbot-config', 09:59:59 INFO - 'download-and-extract', 09:59:59 INFO - 'populate-webroot', 09:59:59 INFO - 'create-virtualenv', 09:59:59 INFO - 'install', 09:59:59 INFO - 'run-tests'), 09:59:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:59:59 INFO - 'download_minidump_stackwalk': True, 09:59:59 INFO - 'download_symbols': 'ondemand', 09:59:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:59:59 INFO - 'tooltool.py': '/tools/tooltool.py', 09:59:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:59:59 INFO - '/tools/misc-python/virtualenv.py')}, 09:59:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:59:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:59:59 INFO - 'installer_path': 'installer.exe', 09:59:59 INFO - 'log_level': 'info', 09:59:59 INFO - 'log_name': 'talos', 09:59:59 INFO - 'log_to_console': True, 09:59:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:59:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:59:59 INFO - 'opt_config_files': (), 09:59:59 INFO - 'pip_index': False, 09:59:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:59:59 INFO - 'cmd': ('bash', 09:59:59 INFO - '-c', 09:59:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:59:59 INFO - 'enabled': True, 09:59:59 INFO - 'halt_on_failure': False, 09:59:59 INFO - 'name': 'check_screen_resolution'},), 09:59:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:59:59 INFO - 'cmd': ('bash', 09:59:59 INFO - '-c', 09:59:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:59:59 INFO - 'enabled': True, 09:59:59 INFO - 'halt_on_failure': False, 09:59:59 INFO - 'name': 'check_screen_resolution'},), 09:59:59 INFO - 'run_cmd_checks_enabled': True, 09:59:59 INFO - 'sps_profile': False, 09:59:59 INFO - 'sps_profile_interval': 0, 09:59:59 INFO - 'suite': 'dromaeojs-e10s', 09:59:59 INFO - 'system_bits': '64', 09:59:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:59:59 INFO - 'title': 't-yosemite-r7-0028', 09:59:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:59:59 INFO - 'use_talos_json': True, 09:59:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:59:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:59:59 INFO - 'work_dir': 'build'} 09:59:59 INFO - ##### 09:59:59 INFO - ##### Running clobber step. 09:59:59 INFO - ##### 09:59:59 INFO - Running pre-action listener: _resource_record_pre_action 09:59:59 INFO - Running main action method: clobber 09:59:59 INFO - rmtree: /builds/slave/test/build 09:59:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:59 INFO - Running post-action listener: _resource_record_post_action 09:59:59 INFO - ##### 09:59:59 INFO - ##### Running read-buildbot-config step. 09:59:59 INFO - ##### 09:59:59 INFO - Running pre-action listener: _resource_record_pre_action 09:59:59 INFO - Running main action method: read_buildbot_config 09:59:59 INFO - Using buildbot properties: 09:59:59 INFO - { 09:59:59 INFO - "properties": { 09:59:59 INFO - "buildnumber": 25, 09:59:59 INFO - "product": "firefox", 09:59:59 INFO - "script_repo_revision": "production", 09:59:59 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:59:59 INFO - "repository": "", 09:59:59 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:59:59 INFO - "buildid": "20151124083121", 09:59:59 INFO - "slavename": "t-yosemite-r7-0028", 09:59:59 INFO - "pgo_build": "False", 09:59:59 INFO - "basedir": "/builds/slave/test", 09:59:59 INFO - "project": "", 09:59:59 INFO - "platform": "yosemite_r7", 09:59:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:59:59 INFO - "slavebuilddir": "test", 09:59:59 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:59:59 INFO - "branch": "fx-team", 09:59:59 INFO - "repo_path": "integration/fx-team", 09:59:59 INFO - "stage_platform": "macosx64", 09:59:59 INFO - "builduid": "57ec50228a394e12a2ddb244727a7fda", 09:59:59 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:59:59 INFO - }, 09:59:59 INFO - "sourcestamp": { 09:59:59 INFO - "repository": "", 09:59:59 INFO - "hasPatch": false, 09:59:59 INFO - "project": "", 09:59:59 INFO - "branch": "fx-team-macosx64-talos", 09:59:59 INFO - "changes": [ 09:59:59 INFO - { 09:59:59 INFO - "category": null, 09:59:59 INFO - "files": [ 09:59:59 INFO - { 09:59:59 INFO - "url": null, 09:59:59 INFO - "name": "https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 09:59:59 INFO - } 09:59:59 INFO - ], 09:59:59 INFO - "repository": "", 09:59:59 INFO - "rev": "d516d82f29a2636c5834c7f3c932025b8e85a8ad", 09:59:59 INFO - "who": "jwein@mozilla.com", 09:59:59 INFO - "when": 1448385641, 09:59:59 INFO - "number": 6700853, 09:59:59 INFO - "comments": "Bug 1213421 - Add a test that verifies the text of a notification is present. r=MattN", 09:59:59 INFO - "project": "", 09:59:59 INFO - "at": "Tue 24 Nov 2015 09:20:41", 09:59:59 INFO - "branch": "fx-team-macosx64-talos", 09:59:59 INFO - "revlink": "", 09:59:59 INFO - "properties": [ 09:59:59 INFO - [ 09:59:59 INFO - "buildid", 09:59:59 INFO - "20151124083121", 09:59:59 INFO - "Change" 09:59:59 INFO - ], 09:59:59 INFO - [ 09:59:59 INFO - "builduid", 09:59:59 INFO - "57ec50228a394e12a2ddb244727a7fda", 09:59:59 INFO - "Change" 09:59:59 INFO - ], 09:59:59 INFO - [ 09:59:59 INFO - "pgo_build", 09:59:59 INFO - "False", 09:59:59 INFO - "Change" 09:59:59 INFO - ] 09:59:59 INFO - ], 09:59:59 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:59:59 INFO - } 09:59:59 INFO - ], 09:59:59 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:59:59 INFO - } 09:59:59 INFO - } 09:59:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 09:59:59 INFO - Running post-action listener: _resource_record_post_action 09:59:59 INFO - ##### 09:59:59 INFO - ##### Running download-and-extract step. 09:59:59 INFO - ##### 09:59:59 INFO - Running pre-action listener: _resource_record_pre_action 09:59:59 INFO - Running main action method: download_and_extract 09:59:59 INFO - mkdir: /builds/slave/test/build/tests 09:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:59:59 INFO - https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:59:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/test_packages.json 09:59:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/test_packages.json 09:59:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:59:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:00:01 INFO - Downloaded 1149 bytes. 10:00:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:00:01 INFO - Using the following test package requirements: 10:00:01 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:00:01 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:00:01 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 10:00:01 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:00:01 INFO - u'jsshell-mac.zip'], 10:00:01 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:00:01 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 10:00:01 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:00:01 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:00:01 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 10:00:01 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:00:01 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 10:00:01 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:00:01 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 10:00:01 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 10:00:01 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 10:00:01 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 10:00:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:00:01 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')]} 10:00:01 INFO - https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:00:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:00:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:00:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/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 10:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/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 10:00:02 INFO - Downloaded 17526956 bytes. 10:00:02 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 10:00:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:00:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:00:05 INFO - Return code: 0 10:00:05 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 10:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:05 INFO - https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:00:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:00:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:00:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/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 10:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/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 10:00:06 INFO - Downloaded 17526956 bytes. 10:00:06 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 10:00:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 10:00:06 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 10:00:09 INFO - Return code: 0 10:00: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')]} 10:00:09 INFO - https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:00:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:00:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:00:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/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 10:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/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 10:00:10 INFO - Downloaded 11130997 bytes. 10:00:10 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 10:00:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 10:00:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 10:00:10 INFO - Return code: 0 10:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:00:10 INFO - https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:00:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:00:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:00:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 10:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/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 10:00:13 INFO - Downloaded 109909020 bytes. 10:00:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:00:13 INFO - mkdir: /builds/slave/test/properties 10:00:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:00:13 INFO - Writing to file /builds/slave/test/properties/build_url 10:00:13 INFO - Contents: 10:00:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 10:00:13 INFO - Running post-action listener: _resource_record_post_action 10:00:13 INFO - Running post-action listener: set_extra_try_arguments 10:00:13 INFO - ##### 10:00:13 INFO - ##### Running populate-webroot step. 10:00:13 INFO - ##### 10:00:13 INFO - Running pre-action listener: _resource_record_pre_action 10:00:13 INFO - Running main action method: populate_webroot 10:00:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:13 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:00:13 INFO - '../fennec_ids.txt'], 10:00:13 INFO - 'tests': ['tcheck2']}, 10:00:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:13 INFO - '--tppagecycles', 10:00:13 INFO - '7'], 10:00:13 INFO - 'tests': ['tsvgm']}}, 10:00:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:00:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:00:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:00:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:00:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:00:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:13 INFO - 'talos_options': ['--e10s'], 10:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:13 INFO - 'tests': ['damp', 'tps']}, 10:00:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:13 INFO - 'talos_options': ['--e10s'], 10:00:13 INFO - 'tests': ['damp', 'tps']}, 10:00:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:00:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:13 INFO - 'other': {'tests': ['a11yr', 10:00:13 INFO - 'ts_paint', 10:00:13 INFO - 'tpaint', 10:00:13 INFO - 'sessionrestore', 10:00:13 INFO - 'sessionrestore_no_auto_restore']}, 10:00:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:00:13 INFO - 'tests': ['a11yr', 10:00:13 INFO - 'ts_paint', 10:00:13 INFO - 'tpaint', 10:00:13 INFO - 'sessionrestore', 10:00:13 INFO - 'sessionrestore_no_auto_restore']}, 10:00:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:00:13 INFO - 'tests': ['a11yr', 10:00:13 INFO - 'ts_paint', 10:00:13 INFO - 'tpaint', 10:00:13 INFO - 'sessionrestore', 10:00:13 INFO - 'sessionrestore_no_auto_restore']}, 10:00:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:00:13 INFO - 'tests': ['a11yr', 10:00:13 INFO - 'ts_paint', 10:00:13 INFO - 'tpaint', 10:00:13 INFO - 'sessionrestore', 10:00:13 INFO - 'sessionrestore_no_auto_restore']}, 10:00:13 INFO - 'other_l64': {'tests': ['a11yr', 10:00:13 INFO - 'ts_paint', 10:00:13 INFO - 'tpaint', 10:00:13 INFO - 'sessionrestore', 10:00:13 INFO - 'sessionrestore_no_auto_restore']}, 10:00:13 INFO - 'other_nol64': {'tests': ['a11yr', 10:00:13 INFO - 'ts_paint', 10:00:13 INFO - 'tpaint', 10:00:13 INFO - 'sessionrestore', 10:00:13 INFO - 'sessionrestore_no_auto_restore']}, 10:00:13 INFO - 'svgr': {'tests': ['tsvgx', 10:00:13 INFO - 'tsvgr_opacity', 10:00:13 INFO - 'tart', 10:00:13 INFO - 'tscrollx', 10:00:13 INFO - 'cart']}, 10:00:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:00:13 INFO - 'tests': ['tsvgx', 10:00:13 INFO - 'tsvgr_opacity', 10:00:13 INFO - 'tart', 10:00:13 INFO - 'tscrollx', 10:00:13 INFO - 'cart']}, 10:00:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:13 INFO - 'tests': ['tp5o']}, 10:00:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:13 INFO - 'talos_options': ['--e10s'], 10:00:13 INFO - 'tests': ['tp5o']}, 10:00:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:13 INFO - 'talos_options': ['--xperf_path', 10:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:13 INFO - 'tests': ['tp5n']}, 10:00:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:13 INFO - 'talos_options': ['--e10s', 10:00:13 INFO - '--xperf_path', 10:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:13 INFO - 'tests': ['tp5n']}}, 10:00:13 INFO - 'talos.zip': {'path': '', 10:00:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:13 INFO - Running post-action listener: _resource_record_post_action 10:00:13 INFO - ##### 10:00:13 INFO - ##### Running create-virtualenv step. 10:00:13 INFO - ##### 10:00:13 INFO - Running pre-action listener: _resource_record_pre_action 10:00:13 INFO - Running main action method: create_virtualenv 10:00:13 INFO - Creating virtualenv /builds/slave/test/build/venv 10:00:13 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 10:00:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:00:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:14 INFO - Using real prefix '/tools/python27' 10:00:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:00:14 INFO - Installing distribute.............................................................................................................................................................................................done. 10:00:17 INFO - Installing pip.................done. 10:00:17 INFO - Return code: 0 10:00:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:00:17 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')]} 10:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:17 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')]} 10:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:17 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 0x1088ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1b257b6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d19f0>, '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 0x108530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c48c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/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.S6ZFGohRYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:00:17 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 10:00:17 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 10:00:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/Render', 10:00:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:17 INFO - 'HOME': '/Users/cltbld', 10:00:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:17 INFO - 'LOGNAME': 'cltbld', 10:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:17 INFO - 'MOZ_NO_REMOTE': '1', 10:00:17 INFO - 'NO_EM_RESTART': '1', 10:00:17 INFO - 'PAGER': '/bin/cat', 10:00:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:17 INFO - 'PWD': '/builds/slave/test', 10:00:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:17 INFO - 'SHELL': '/bin/bash', 10:00:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S6ZFGohRYa/Listeners', 10:00:17 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:00:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:17 INFO - 'USER': 'cltbld', 10:00:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:17 INFO - 'XPC_FLAGS': '0x0', 10:00:17 INFO - 'XPC_SERVICE_NAME': '0', 10:00:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:17 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 10:00:17 INFO - Cleaning up... 10:00:17 INFO - Return code: 0 10:00:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:00:17 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')]} 10:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:17 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')]} 10:00:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:17 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 0x1088ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1b257b6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d19f0>, '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 0x108530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c48c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/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.S6ZFGohRYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:00:17 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 10:00:17 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 10:00:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/Render', 10:00:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:17 INFO - 'HOME': '/Users/cltbld', 10:00:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:17 INFO - 'LOGNAME': 'cltbld', 10:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:17 INFO - 'MOZ_NO_REMOTE': '1', 10:00:17 INFO - 'NO_EM_RESTART': '1', 10:00:17 INFO - 'PAGER': '/bin/cat', 10:00:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:17 INFO - 'PWD': '/builds/slave/test', 10:00:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:17 INFO - 'SHELL': '/bin/bash', 10:00:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S6ZFGohRYa/Listeners', 10:00:17 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:00:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:17 INFO - 'USER': 'cltbld', 10:00:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:17 INFO - 'XPC_FLAGS': '0x0', 10:00:17 INFO - 'XPC_SERVICE_NAME': '0', 10:00:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:18 INFO - Downloading/unpacking psutil>=0.7.1 10:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:20 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:00:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:00:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:20 INFO - Installing collected packages: psutil 10:00:20 INFO - Running setup.py install for psutil 10:00:20 INFO - building 'psutil._psutil_osx' extension 10:00:20 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 10:00:20 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 10:00:20 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 10:00:21 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 10:00:21 INFO - building 'psutil._psutil_posix' extension 10:00:21 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 10:00:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:00:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:00:21 INFO - ^ 10:00:21 INFO - 1 warning generated. 10:00:21 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 10:00:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:21 INFO - Successfully installed psutil 10:00:21 INFO - Cleaning up... 10:00:21 INFO - Return code: 0 10:00:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:00:21 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')]} 10:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:21 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')]} 10:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:21 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 0x1088ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1b257b6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d19f0>, '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 0x108530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c48c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/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.S6ZFGohRYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:00:21 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 10:00:21 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 10:00:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/Render', 10:00:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:21 INFO - 'HOME': '/Users/cltbld', 10:00:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:21 INFO - 'LOGNAME': 'cltbld', 10:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:21 INFO - 'MOZ_NO_REMOTE': '1', 10:00:21 INFO - 'NO_EM_RESTART': '1', 10:00:21 INFO - 'PAGER': '/bin/cat', 10:00:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:21 INFO - 'PWD': '/builds/slave/test', 10:00:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:21 INFO - 'SHELL': '/bin/bash', 10:00:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S6ZFGohRYa/Listeners', 10:00:21 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:00:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:21 INFO - 'USER': 'cltbld', 10:00:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:21 INFO - 'XPC_FLAGS': '0x0', 10:00:21 INFO - 'XPC_SERVICE_NAME': '0', 10:00:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:00:21 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 10:00:21 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 10:00:21 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 10:00:21 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 10:00:21 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 10:00:21 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 10:00:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:00:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:00:23 INFO - Installing collected packages: mozsystemmonitor 10:00:23 INFO - Running setup.py install for mozsystemmonitor 10:00:23 INFO - Successfully installed mozsystemmonitor 10:00:23 INFO - Cleaning up... 10:00:24 INFO - Return code: 0 10:00:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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', '--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 0x1088ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1b257b6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d19f0>, '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 0x108530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c48c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/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.S6ZFGohRYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:00:24 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 10:00:24 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 10:00:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/Render', 10:00:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:24 INFO - 'HOME': '/Users/cltbld', 10:00:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:24 INFO - 'LOGNAME': 'cltbld', 10:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:24 INFO - 'MOZ_NO_REMOTE': '1', 10:00:24 INFO - 'NO_EM_RESTART': '1', 10:00:24 INFO - 'PAGER': '/bin/cat', 10:00:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:24 INFO - 'PWD': '/builds/slave/test', 10:00:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:24 INFO - 'SHELL': '/bin/bash', 10:00:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S6ZFGohRYa/Listeners', 10:00:24 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:00:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:24 INFO - 'USER': 'cltbld', 10:00:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:24 INFO - 'XPC_FLAGS': '0x0', 10:00:24 INFO - 'XPC_SERVICE_NAME': '0', 10:00:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:24 INFO - Downloading/unpacking blobuploader==1.2.4 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:24 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 10:00:26 INFO - Downloading blobuploader-1.2.4.tar.gz 10:00:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:00:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00: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 10:00:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:00:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:27 INFO - Downloading docopt-0.6.1.tar.gz 10:00:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:00:27 INFO - Installing collected packages: blobuploader, requests, docopt 10:00:27 INFO - Running setup.py install for blobuploader 10:00:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:00:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:00:27 INFO - Running setup.py install for requests 10:00:28 INFO - Running setup.py install for docopt 10:00:28 INFO - Successfully installed blobuploader requests docopt 10:00:28 INFO - Cleaning up... 10:00:28 INFO - Return code: 0 10:00:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:28 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')]} 10:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:28 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')]} 10:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:28 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 0x1088ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1b257b6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d19f0>, '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 0x108530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c48c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/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.S6ZFGohRYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:00:28 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 10:00:28 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 10:00:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/Render', 10:00:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:28 INFO - 'HOME': '/Users/cltbld', 10:00:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:28 INFO - 'LOGNAME': 'cltbld', 10:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:28 INFO - 'MOZ_NO_REMOTE': '1', 10:00:28 INFO - 'NO_EM_RESTART': '1', 10:00:28 INFO - 'PAGER': '/bin/cat', 10:00:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:28 INFO - 'PWD': '/builds/slave/test', 10:00:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:28 INFO - 'SHELL': '/bin/bash', 10:00:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S6ZFGohRYa/Listeners', 10:00:28 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:00:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:28 INFO - 'USER': 'cltbld', 10:00:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:28 INFO - 'XPC_FLAGS': '0x0', 10:00:28 INFO - 'XPC_SERVICE_NAME': '0', 10:00:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:28 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-YhhGE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:28 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-C3vCPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-oPVtgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-txCsyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-SIEqih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-WyizHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-hDAiys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-QbHEF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-gjavG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-el4WBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-iEkYrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:29 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-UluKsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-4Vl38O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-TtnNZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-pw6bs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-VI2qLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:30 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-UWgVPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:30 INFO - Running setup.py install for manifestparser 10:00:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:30 INFO - Running setup.py install for mozcrash 10:00:30 INFO - Running setup.py install for mozdebug 10:00:31 INFO - Running setup.py install for mozdevice 10:00:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:00:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:31 INFO - Running setup.py install for mozfile 10:00:31 INFO - Running setup.py install for mozhttpd 10:00:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:31 INFO - Running setup.py install for mozinfo 10:00:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:31 INFO - Running setup.py install for mozInstall 10:00:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:31 INFO - Running setup.py install for mozleak 10:00:31 INFO - Running setup.py install for mozlog 10:00:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:32 INFO - Running setup.py install for moznetwork 10:00:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:32 INFO - Running setup.py install for mozprocess 10:00:32 INFO - Running setup.py install for mozprofile 10:00:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:32 INFO - Running setup.py install for mozrunner 10:00:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:32 INFO - Running setup.py install for mozscreenshot 10:00:32 INFO - Running setup.py install for moztest 10:00:33 INFO - Running setup.py install for mozversion 10:00:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:33 INFO - Cleaning up... 10:00:33 INFO - Return code: 0 10:00:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00: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')]} 10:00:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:33 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 0x1088ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1b257b6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d19f0>, '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 0x108530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c48c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/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.S6ZFGohRYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:00:33 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 10:00:33 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 10:00:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/Render', 10:00:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:33 INFO - 'HOME': '/Users/cltbld', 10:00:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:33 INFO - 'LOGNAME': 'cltbld', 10:00:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:33 INFO - 'MOZ_NO_REMOTE': '1', 10:00:33 INFO - 'NO_EM_RESTART': '1', 10:00:33 INFO - 'PAGER': '/bin/cat', 10:00:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:33 INFO - 'PWD': '/builds/slave/test', 10:00:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:33 INFO - 'SHELL': '/bin/bash', 10:00:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S6ZFGohRYa/Listeners', 10:00:33 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:00:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:33 INFO - 'USER': 'cltbld', 10:00:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:33 INFO - 'XPC_FLAGS': '0x0', 10:00:33 INFO - 'XPC_SERVICE_NAME': '0', 10:00:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:33 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-bCZv5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:33 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)) 10:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:33 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-dBPs7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:33 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)) 10:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:33 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-IoG0G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:33 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)) 10:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:33 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-y1n4Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:33 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)) 10:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:33 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-o7AsMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:33 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)) 10:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:33 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qPNVF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:34 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)) 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-XVfI1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:34 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)) 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-xZGUsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:34 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)) 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-LkKTK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:34 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)) 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-3B58g2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-1M8S0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:34 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)) 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-kVeVSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:34 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)) 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Jy216h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:34 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)) 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-iU8oY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:34 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)) 10:00:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:34 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-BiAADY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:35 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)) 10:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-HxQbhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:35 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)) 10:00:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:35 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-1RhGXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:35 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)) 10:00:35 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)) 10:00:35 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)) 10:00:35 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)) 10:00:35 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)) 10:00:35 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)) 10:00:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:37 INFO - Downloading blessings-1.5.1.tar.gz 10:00:37 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 10:00:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:37 INFO - Installing collected packages: blessings 10:00:37 INFO - Running setup.py install for blessings 10:00:37 INFO - Successfully installed blessings 10:00:37 INFO - Cleaning up... 10:00:37 INFO - Return code: 0 10:00:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:38 INFO - Reading from file tmpfile_stdout 10:00:38 INFO - Current package versions: 10:00:38 INFO - blessings == 1.5.1 10:00:38 INFO - blobuploader == 1.2.4 10:00:38 INFO - docopt == 0.6.1 10:00:38 INFO - manifestparser == 1.1 10:00:38 INFO - mozInstall == 1.12 10:00:38 INFO - mozcrash == 0.16 10:00:38 INFO - mozdebug == 0.1 10:00:38 INFO - mozdevice == 0.47 10:00:38 INFO - mozfile == 1.2 10:00:38 INFO - mozhttpd == 0.7 10:00:38 INFO - mozinfo == 0.9 10:00:38 INFO - mozleak == 0.1 10:00:38 INFO - mozlog == 3.1 10:00:38 INFO - moznetwork == 0.27 10:00:38 INFO - mozprocess == 0.22 10:00:38 INFO - mozprofile == 0.27 10:00:38 INFO - mozrunner == 6.11 10:00:38 INFO - mozscreenshot == 0.1 10:00:38 INFO - mozsystemmonitor == 0.0 10:00:38 INFO - moztest == 0.7 10:00:38 INFO - mozversion == 1.4 10:00:38 INFO - psutil == 3.1.1 10:00:38 INFO - requests == 1.2.3 10:00:38 INFO - wsgiref == 0.1.2 10:00:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:38 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')]} 10:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:38 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')]} 10:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:38 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 0x1088ad490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10888a228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1b257b6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1087d19f0>, '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 0x108530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c48c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/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.S6ZFGohRYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:00:38 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 10:00:38 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 10:00:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/Render', 10:00:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:38 INFO - 'HOME': '/Users/cltbld', 10:00:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:38 INFO - 'LOGNAME': 'cltbld', 10:00:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:38 INFO - 'MOZ_NO_REMOTE': '1', 10:00:38 INFO - 'NO_EM_RESTART': '1', 10:00:38 INFO - 'PAGER': '/bin/cat', 10:00:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:38 INFO - 'PWD': '/builds/slave/test', 10:00:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:38 INFO - 'SHELL': '/bin/bash', 10:00:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S6ZFGohRYa/Listeners', 10:00:38 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:00:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:38 INFO - 'USER': 'cltbld', 10:00:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:38 INFO - 'XPC_FLAGS': '0x0', 10:00:38 INFO - 'XPC_SERVICE_NAME': '0', 10:00:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:38 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)) 10:00:38 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)) 10:00:38 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)) 10:00:38 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)) 10:00:38 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)) 10:00:38 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)) 10:00:38 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)) 10:00:38 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)) 10:00:38 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)) 10:00:38 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)) 10:00:38 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)) 10:00:38 INFO - Cleaning up... 10:00:38 INFO - Return code: 0 10:00:38 INFO - Running post-action listener: _resource_record_post_action 10:00:38 INFO - Running post-action listener: _start_resource_monitoring 10:00:38 INFO - Starting resource monitoring. 10:00:38 INFO - ##### 10:00:38 INFO - ##### Running install step. 10:00:38 INFO - ##### 10:00:38 INFO - Running pre-action listener: _resource_record_pre_action 10:00:38 INFO - Running main action method: install 10:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:38 INFO - Reading from file tmpfile_stdout 10:00:38 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:38 INFO - Reading from file tmpfile_stdout 10:00:38 INFO - Output received: 10:00:38 INFO - Usage: mozinstall [options] installer 10:00:38 INFO - Options: 10:00:38 INFO - -h, --help show this help message and exit 10:00:38 INFO - -d DEST, --destination=DEST 10:00:38 INFO - Directory to install application into. [default: 10:00:38 INFO - "/builds/slave/test"] 10:00:38 INFO - --app=APP Application being installed. [default: firefox] 10:00:38 INFO - mkdir: /builds/slave/test/build/application 10:00:38 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'] 10:00:38 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 10:01:09 INFO - Reading from file tmpfile_stdout 10:01:09 INFO - Output received: 10:01:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:01:09 INFO - Running post-action listener: _resource_record_post_action 10:01:09 INFO - ##### 10:01:09 INFO - ##### Running run-tests step. 10:01:09 INFO - ##### 10:01:09 INFO - Running pre-action listener: _resource_record_pre_action 10:01:09 INFO - Running main action method: run_tests 10:01:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:01:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:01:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:01:09 INFO - 2015-11-24 10:01:09.328 screenresolution[2905:27154] starting screenresolution argv=screenresolution get 10:01:09 INFO - 2015-11-24 10:01:09.331 screenresolution[2905:27154] Display 0: 1600x1200x32@60 10:01:09 INFO - 2015-11-24 10:01:09.337 screenresolution[2906:27156] starting screenresolution argv=screenresolution list 10:01:09 INFO - Available Modes on Display 0 10:01:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:01:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:01:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:01:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:01:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:01:09 INFO - Intel Iris: 10:01:09 INFO - Chipset Model: Intel Iris 10:01:09 INFO - Type: GPU 10:01:09 INFO - Bus: Built-In 10:01:09 INFO - VRAM (Dynamic, Max): 1536 MB 10:01:09 INFO - Vendor: Intel (0x8086) 10:01:09 INFO - Device ID: 0x0a2e 10:01:09 INFO - Revision ID: 0x0009 10:01:09 INFO - Displays: 10:01:09 INFO - Display: 10:01:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:01:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:01:09 INFO - Display Serial Number: 1600x1200 60 10:01:09 INFO - Main Display: Yes 10:01:09 INFO - Mirror: Off 10:01:09 INFO - Online: Yes 10:01:09 INFO - Rotation: Supported 10:01:09 INFO - Return code: 0 10:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:01:09 INFO - Python 2.7.3 10:01:09 INFO - Return code: 0 10:01:09 INFO - grabbing minidump binary from tooltool 10:01: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')]} 10:01:09 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 0x1087d19f0>, '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 0x108530db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1087c48c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:01:09 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 10:01:09 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 10:01:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:01:09 INFO - Return code: 0 10:01:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:01:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:01:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:01:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:01:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:01:09 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/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost'] in /builds/slave/test/build 10:01:09 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/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --webServer localhost 10:01:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4M6waryZ8X/Render', 10:01:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:01:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:01:09 INFO - 'HOME': '/Users/cltbld', 10:01:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:01:09 INFO - 'LOGNAME': 'cltbld', 10:01:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:01:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:09 INFO - 'MOZ_NO_REMOTE': '1', 10:01:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:01:09 INFO - 'NO_EM_RESTART': '1', 10:01:09 INFO - 'PAGER': '/bin/cat', 10:01:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:09 INFO - 'PWD': '/builds/slave/test', 10:01:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:01:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:01:09 INFO - 'SHELL': '/bin/bash', 10:01:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S6ZFGohRYa/Listeners', 10:01:09 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 10:01:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:01:09 INFO - 'USER': 'cltbld', 10:01:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:01:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:09 INFO - 'XPC_FLAGS': '0x0', 10:01:09 INFO - 'XPC_SERVICE_NAME': '0', 10:01:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:01:09 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/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost'] with output_timeout 3600 10:01:09 INFO - mozversion INFO | application_buildid: 20151124083121 10:01:09 INFO - mozversion INFO | application_changeset: d516d82f29a2636c5834c7f3c932025b8e85a8ad 10:01:09 INFO - mozversion INFO | application_display_name: Nightly 10:01:09 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:01:09 INFO - mozversion INFO | application_name: Firefox 10:01:09 INFO - mozversion INFO | application_remotingname: firefox 10:01:09 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:01:09 INFO - mozversion INFO | application_vendor: Mozilla 10:01:09 INFO - mozversion INFO | application_version: 45.0a1 10:01:09 INFO - mozversion INFO | platform_buildid: 20151124083121 10:01:09 INFO - mozversion INFO | platform_changeset: d516d82f29a2636c5834c7f3c932025b8e85a8ad 10:01:09 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:01:09 INFO - mozversion INFO | platform_version: 45.0a1 10:01:09 INFO - 2015-11-24 10:01:09,875 DEBUG : using testdate: 1448388069 10:01:09 INFO - 2015-11-24 10:01:09,875 DEBUG : actual date: 1448388069 10:01:09 INFO - 2015-11-24 10:01:09,962 INFO : starting webserver on 'localhost:52359' 10:01:09 INFO - 2015-11-24 10:01:09,963 INFO : Starting test suite t-yosemite-r7-0028.e 10:01:09 INFO - 2015-11-24 10:01:09,963 INFO : Starting test dromaeo_css 10:01:09 INFO - 2015-11-24 10:01:09,963 DEBUG : operating with platform_type : mac_ 10:01:09 INFO - 2015-11-24 10:01:09,964 INFO : Initialising browser for dromaeo_css test... 10:01:09 INFO - 2015-11-24 10:01:09,975 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpo5RMpf/profile http://localhost:52359/getInfo.html 10:01:12 INFO - 2015-11-24 10:01:12,712 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:01:12 INFO - 2015-11-24 10:01:12,713 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:01:12 INFO - 2015-11-24 10:01:12,713 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:01:12 INFO - 2015-11-24 10:01:12,713 DEBUG : BROWSER_OUTPUT: __metrics 10:01:13 INFO - 2015-11-24 10:01:13,344 INFO : Browser initialized. 10:01:13 INFO - 2015-11-24 10:01:13,344 INFO : Running cycle 1/1 for dromaeo_css test... 10:01:13 INFO - 2015-11-24 10:01:13,344 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpo5RMpf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:01:25 INFO - 2015-11-24 10:01:25,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 237711360 10:01:25 INFO - 2015-11-24 10:01:25,224 DEBUG : BROWSER_OUTPUT: 10:02:14 INFO - 2015-11-24 10:02:14,907 DEBUG : BROWSER_OUTPUT: 1448388134906 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] 10:04:25 INFO - 2015-11-24 10:04:25,430 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52359/tests/dromaeo/cssquery-ext.html) 10:04:26 INFO - 2015-11-24 10:04:26,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 254689280 10:04:26 INFO - 2015-11-24 10:04:26,799 DEBUG : BROWSER_OUTPUT: 10:07:28 INFO - 2015-11-24 10:07:28,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/dromaeo/cssquery-ext.html (next: http://localhost:52359/tests/dromaeo/cssquery-jquery.html) 10:07:29 INFO - 2015-11-24 10:07:29,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 263028736 10:07:29 INFO - 2015-11-24 10:07:29,375 DEBUG : BROWSER_OUTPUT: 10:10:31 INFO - 2015-11-24 10:10:31,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52359/tests/dromaeo/cssquery-mootools.html) 10:10:31 INFO - 2015-11-24 10:10:31,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 265113600 10:10:31 INFO - 2015-11-24 10:10:31,636 DEBUG : BROWSER_OUTPUT: 10:13:33 INFO - 2015-11-24 10:13:33,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52359/tests/dromaeo/cssquery-prototype.html) 10:13:33 INFO - 2015-11-24 10:13:33,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 267358208 10:13:33 INFO - 2015-11-24 10:13:33,867 DEBUG : BROWSER_OUTPUT: 10:16:36 INFO - 2015-11-24 10:16:36,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52359/tests/dromaeo/cssquery-yui.html) 10:16:36 INFO - 2015-11-24 10:16:36,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 270061568 10:16:36 INFO - 2015-11-24 10:16:36,974 DEBUG : BROWSER_OUTPUT: 10:19:39 INFO - 2015-11-24 10:19:39,137 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/dromaeo/cssquery-yui.html (next: http://localhost:52359/tests/dromaeo/cssquery-dojo.html) 10:19:39 INFO - 2015-11-24 10:19:39,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 273444864 10:19:39 INFO - 2015-11-24 10:19:39,397 DEBUG : BROWSER_OUTPUT: 10:19:39 INFO - 2015-11-24 10:19:39,397 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:19:39 INFO - 2015-11-24 10:19:39,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:19:39 INFO - 2015-11-24 10:19:39,397 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:19:39 INFO - 2015-11-24 10:19:39,397 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:19:39 INFO - 2015-11-24 10:19:39,398 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2922.2840404100984;3094.443000259954;3434;3505.526753888226;3556.4843097750845;4789.281607758833;5899.439553242435;5902.822915312537;5905.61613495123;5907.88184236315;5758.971205143968;5927.229460170182;5933.3473317934995;5970.73131709073;6059;5298.23175639532;5312.1766126250495;5389.946100539003;5458.5087342139195;5473.261109750192;5451.972740136293;5490.505854473096;5513.8345849624575;5544.500994910457;5545.473180047909;5181.35233095863;5195.246689230078;5291.417944026154;5446.992306423324;5456.48163424476;5336.839894803124;5348.010618035637;5357.973210133924;5376.731163441812;5394.32570928634;5334.519893209591;5342.813001544927;5352.170413585901;5353.625246232766;5427.972860135674;4171.770552619605;5597.104463285855;5920;5925.822225333247;5987.790427335022;6293.370662933716;6301.8109456716375;6328.493720502349;6352.555321127523;6357.237131544198;6360.55476116672;6376.6174029557915;6381;6384.297727249998;6385.297617262097;5758.481736643722;5923.229980102602;6016.308124565643;6082.1789058477425;6144.324124346318;6394.360563943568;6571.244306904767;6571.769988050491;6575.901361479581;6581.901271480931;6082.787102451482;6356.523260755462;6361.109444677749;6374.458171055512;6377.107204991305;6213.285472170668;6313.337099604567;6361;6364.236291644939;6484.578502397329;6354.586951848115;6359.841003974845;6364.84087897797;6374.426301632875;6384.170057892445;6347.174867267318;6366.140571022946;6374.808755737336;6378.394052564999;6383.202099737533;4976.2038073908;5062.594992400599;5068.847934561895;5107.055194788976;5141.357330333708;4578.061497393026;4592.724436533818;4601.723896566216;4604.539546045368;4630.53694630541;5815.244018277597;6008.128821320972;6008.669523176267;6057.666828324484;6059.394060593993;5392.91910621341;6323.5573509854785;6329.936700632935;6428.132202152743;6448.709808058648;5987.1318658794235;6022.247219097613;6037.577369584174;6059.121427393092;6086.543509236825;5404.29744133268;5529.889402211933;5627.212190293362;5630.014747419185;5633.971830140823;5953.851153721105;5965.34381218057;6383.904241436382;6484.708188131545;6498.870022599522;6361.745530178741;6376.553641245068;6416.037594360883;6443.420092191725;6448.258450278278;6290.559660823698;6388.009858471944;6391.201099862517;6583.242927063257;6585.901211481736;5333.306670132858;6309.400606942333;6343.111964324906;6356.904646430215;6374.74501019954;5132.325566307462;6365.52258580599;6393.1688880445245;6415.069814876723;6421.101045853491;6139.386061393825;6147.293061297829;6213.9067913982235;6258.155149055002;6308.495320374451;5229.555487783429;6306.527010474141;6319.368063193644;6321.8735625288155;6332.683365831782;6148.907766383597;6188.9788184948975;6194.659293738888;6239.844003899939;6276.748930042747;6129.8784197560135;6193.690315484298;6244.406781355764;6265.248170219603;6307.180066591313;5183.481651834786;6210.3168651449205;6265.843353916189;6271.122042913905;6277.340879207617 10:19:39 INFO - 2015-11-24 10:19:39,398 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.4500974110941;556.7272036702017;573.0458786121109;585.7217821534769;616.214326733415;39924.60075399249;40262.39606405899;40432.393514097275;40494.59505404945;40569.78290651282;43749.78125109378;43882.56117438825;43933.121337573306;44322.33516497255;44469;9711.514424278776;9775.120239178472;9843.950780246088;9860.556274967608;9908.058734420218;9666.854997175047;9729.756756081084;9731.610735570568;9787.755306117333;9793.265505087147;8474.406791524596;9685.854712179324;9731.756706082333;9739.561719722595;9787.853182202272;9640.61437542501;9679.70960871175;9715.46564938928;9729.221662267037;9732.854007189897;9596.568154433067;9717.61129554817;9721;9734.221262299;9768.36505627132;40281;40444.393334100016;40616.79691601523;40655;40705.796471017755;3270.3622793555264;3284.8850290239966;3322.7840190387788;3561.3767590671528;3784.3566593678866;28795;28837.8278389377;29027.564586531218;29077.854610727023;29220.561691574643;2738.7261273872455;2813.535766598509;2822.8729707163225;2844.937465147779;2958.082994271783;484557;486224.99999999645;486264;487368;488648;58339.12491312634;59321.40678593245;68487;69255;69294.65352673204;67638.66180669065;67696;67822;68092.97860532095;68205;15633.374665013273;15781.842181578037;15788.289526971314;15812.762808557882;16009;12177.990631545696;12187.695307617381;12206.755864882653;12220.694482638006;12360.134790564754;19885.502862428264;19991.500212494804;20052;20122.798772012386;20128.798712012693;8765.035846056928;8959.328050396116;9534.427934323963;9607.951960240154;9622.807543849083;901.8196360727881;995.2485873165714;1050.1808589300358;1078.719532921446;1087.5867170475326;29495;29777.85111074431;29874.253143671147;30372.544411833842;30453.39093218123;867.5185272174004;961.7018724195522;1095.8137116690182;1142.8857114288671;1270.4981532294692;14639.853601463848;15218.467353642569;15262.694746105015;15520.611984700246;15604.375824966874;431047;464289;468252;468858;470484;57671.71164144152;58358.708206459545;58694.82610347769;58972.70513647404;59057.704711476166;1175.9823602645968;1415.9079659822078;1436.4182506084844;1437.6190309567974;1449.0725935401351;29467.705322946495;29694.851525742233;30003.849980749957;30177.7928882851;30370.544441833834;51305.7434712824;51356;51652.22521662253;51700.22449663333;51764;361845;361891;362847;363480;363605;30359.392812144077;32952.505712413855;33415.33169336648;33628.831855840566;33866.830665846515;42385.788071060684;42747.5725242756;42762.57237427586;42833.357499636906;43612.56387436085;35372.29255414929;35841.82079089588;35937;36175.457368138974;36460.63539364572;34941.30117397587;35385;35437.64562354344;35599.28801424009;35992;36044.4593331095;36679.633203667625;36705;36827.447588285664;36945.07637309089;26842.926282949244;30888.69111308948;32270.677293226767;32334.35331293408;32611.34777304488;24906.377340566632;25097;25231;25246.621300680137;25571.616425754 10:19:39 INFO - 2015-11-24 10:19:39,398 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.9138606734385;364.9927001459971;366.38264524276593;367.3754617150841;367.481850590667;15469.381224750996;17904.82095179048;19153.425397238072;19572.31496897609;20202.19191232351;11391.54433822646;11736.647900562975;11756.529738810437;11766.705662377131;19474.610507789872;5192.8701782455555;5200.245964335169;5287.656302340355;5306.495882891119;5310.176922577007;3882.9223415531674;4017.216642754664;5266.262723218752;5668.518175955049;5840.970795146019;5788.710564471759;5808.041673123929;5824.912626310587;5832.883342333151;5843.64938103713;5973.432523910222;6425.58233714807;6426.2931077581425;6426.421622054014;6448.548601597867;5478;5605.915911261334;5606.691631960241;5639.971800141014;5644.040513112781;12199;13061.281629510373;13148.342582870913;13312.534061307904;13318.067735258535;1980.5939782344728;1990.8307793837541;2011.3463124484456;2022.3629556689743;2127.181035301405;8448.915510844936;9152.130547598033;9661.758456038586;9816.116549510507;9921.90078099217;1685.7639930409753;1706.2742368499478;1720.096949101719;1771.8936863788085;1779.6070945677307;98717.53206169831;100379;102188;103315.4834225824;103911;10019.448930308903;10160.187185025181;10964.17768667353;11105.944470277758;11168.497417616227;13121.343932803513;13167.934160329138;13190.802137967938;13241.933790330986;13254;7299.19708832028;7862.921370786219;8214.58927053645;8294.875576866352;8390.244877961013;8190.058143313595;8215.548144852091;8249.79375515617;8265.132161122996;8268.958655206685;4248.511421186541;4254.170436764863;4303.569643035734;4331.242032644274;4365.476142862877;1745.8952462852014;1805.6569251842109;1806.8102849200907;1827.077325950413;1869.9719504207449;914.5884352041475;943.297243553557;1019.2202964731986;1035.254616675992;1042.0777611813598;15759;17719.822801772076;20025.198992040445;20033.29883454072;20406.897965510376;419.2746548471162;432.3557898730931;434.56326391975864;448.4349719353573;455.464828826128;5374.435684253175;6004.279486461653;6009.939900601025;6082.452579267887;6095.238095238095;661229;711879;717863.8213617902;738210.6178938249;767625;93861;129568;130614;131164.34417828041;133567;405.94925634295714;479.7721082485791;487.8024400117958;489.1903899047083;489.87573518773786;11037.337759734442;11240.606578769704;11255.099592032782;11275.436228188722;11311.038561722016;55036.44963550313;55315;55332.72333638467;55960.72019639876;56000;73639;73656.63171684108;74410.25589744034;75208.62395688206;76907.61546192234;10017.849732254168;10116.645917392856;10143.64497242593;10212.540435680561;10239.18086553059;14580.635484112981;15566.533004009898;16557.91721041387;17290.13549322554;20333.881636510134;13102.75523825235;13695.794563081363;15727.370905164124;15757.29092190877;16075.919620401823;15232.923835380752;15577.299021543831;15714.842851571795;15770.92114539466;16004.19979001022;7012.649367531705;10831;16855.831441685426;16943.32226710918;17078.060706661254;7562.810929726801;9920.255980801325;10113.89886101159;10163.034511721375;10181.592736290466;15575.844241557892;15722.528324150293;16260.51218463448;16278.186090695655;16459.177041147654 10:19:39 INFO - 2015-11-24 10:19:39,399 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1578.558003758948;1594.5933786884343;1609.5171448565427;1909.713542968555;1939.825415712586;6589.341065893408;7426.925730742691;8297.045839728426;8459.32325413967;8484;7926.841463170733;8081;8169.59152042397;8211.137830527798;8226.259636632702;2180.858244214125;2205.448637840532;2212.9114835406563;2219.9556008879813;2229.1306390507716;2338.1933233034574;2389.175734371639;2416.6495858100566;2420.6127019676856;2430.052279610953;2345.4253707841604;2359.9646005309933;2373.5964885969343;2381.2618088392655;2385.1651921827397;2341.7424083350816;2346.155384061736;2360.893759780814;2366.3137690069857;2377.5839228135005;2387.1883559589824;2395.772401621843;2403.97596024041;2410.602250628644;2414.99777592299;8260.958695206546;8329.791755206108;8338.24955753979;8351.24838764508;8352.916470835275;4609.262517997138;4873.658843880929;5167.896642067138;5190.844274671728;5220.26916231724;3162.588863447737;3399.184195792992;3425.760196786226;3430.794152350842;3479.495473156378;1023.9846402303972;1039.6101461951769;1047.0524175621076;1050.5535147562255;1070.4861666400172;11012.063974562092;11020.944895275472;11025.117990560735;11026.834597480964;11067.391293478855;4151.024509240327;4486.842960496432;4625.699329543569;4726.078414709099;4773.284007398918;9495.43027418357;9545.665901693408;9552.522373881278;9580.520973951274;9598.088181622734;5147.073526765218;5167.689938603696;5180.1711726124395;5180.32655754757;5229.424763276036;4677.812887484531;4693.953060469352;4701.412323459567;4711.976440117777;4737.95262047382;3822.2737679840743;3879.9718074710227;3898.3567711327314;3911.882643520699;3919;1291.063978615515;1294.9417276222594;1295.488282128554;1297.241113948332;1306.9738605228033;1340.3700260877372;1359.952401665937;1376.6558360409897;1376.8967327450482;1385.2173521960262;7660.540367577852;7818.804529886685;7832.334251588565;7837.1379148293645;7840.686372545034;486.79068000759304;487.4370102531582;490.80122550367156;494.22900275570225;505.86847419671153;6153.815385538441;6173.32093469718;6176.938230617726;6199.814005579839;6234.0337247726675;9570.665026724171;9802.117809397188;9895.109440150278;9971.700848974542;9983.750406239902;8347.332213422911;8381;9138.360314777901;9904.950475247577;9938.552765125587;7676.731314403969;7833.764987050397;7869.921300787033;7873.25204105609;7913.061299981541;7797.415193860596;7825.256600622932;7838.843223135619;7844.725434609762;7890.408219383455;6706;8731.388802783744;9119.316051296311;9179.44923304577;9190.988991211096;9121.680741174026;9374.81250374975;9399.060093990547;9419.952900235729;9489.66786162481;7338.853222935405;7382;7407.851842963219;7431.665575049027;7435.4795164337975;7816.06207255133;7930.722424715107;7987.201279871966;8005.359571234404;8022.679092836454;7459.328660420588;7483.289087536676;7501.212372701006;7533.849323013618;7630.465867389452;7347.302006309392;7374.594397308199;7401.259874012556;7482.775516734507;7499.737509187153;7475.289847464483;7522;7575.128860180929;7578.621068946641;7582.241775822374;6830.829229269308;6842.110525631636;6866.1760588727675;6905.792826215222;6911;6316.7157477914525;6494.772682956074;6762.154730658668;6943.583384996714;6946.79159625212 10:19:39 INFO - 2015-11-24 10:19:39,401 DEBUG : BROWSER_OUTPUT: |4;prototype.html;322.617698027837;326.5787134596371;332.54607460815987;336.1948134218545;336.21829247000727;5572.637778544392;6790.219124800649;6894.172699276094;6984.546004509703;6986.6855991480315;6704.161979752531;6876;6915.51591388603;6923.619200943946;6970.442364610832;5024.673396229252;5041.571466425358;5046.369203849519;5047.0915235257635;5056.938043010954;4879.682820616648;5064.55660136861;5070.822521211759;5071;5076.796928122871;4938.16051271283;4962.330085438456;4965.404151501807;4970.627202959774;4998.450170481244;4945.530174633422;4952.826651067214;4955.157623204064;4966.453690094087;4973.129702302101;4041.4948131483566;4118.814653340577;4120.175964807021;4206.91586168278;4209.137126888981;6570.671466426707;6594.472442204612;6612.206535215805;6612.900806487906;6622.801315960529;5797.391273916221;5878.294604647427;5889.381614930414;5895.263092113486;5904.763809447617;7147.53541019832;7349.338559529615;7350.228226036296;7369.152547457057;7391.85216295671;4064.9593504065174;4709.458412282563;4710.505396933307;4713.882152946169;4721.787519561628;7075.504714669975;7861.48900321483;7863.882041769378;7881.881771773428;7892.171322011163;4653.511381304982;4763.904721905543;4773.427188737304;4777.116233496814;4792.95207047932;4869.95130048695;4882.048000639912;4889.633277504201;4892.755362231874;4902.362692849907;5931.584789064724;5938.6139900907165;5945.048792193228;5948.5538584605465;5958.761649534057;7290.3438690518105;7479.915412265191;7530.6611202496015;7543.755280378786;7558.168601453835;1493.402638944431;1605.9357625695075;1700.4558541266676;1702.6339337042596;1707.2061491406555;898.9730308090637;1073.5759375046969;1082.5128692088592;1087.363892123101;1090.8636420447444;6231.003039513656;6403.879321118786;6910.274421185703;6924.792256232321;6927.480438966997;6195.349488303754;7742.4193185510185;7744.883826742604;7769.650365733442;7788.649510772028;5680.573956953245;6747.392734653905;6904.654767261617;6909.827254318581;6919.411849992706;3759.548854137466;3797.35444974355;3986.6412022918075;4058.776767277769;4074.6129117733767;8072.878906816402;8088.797780055428;8109.675612975533;8111.107778144399;8116.391270654724;7855.175206603339;8100.635471403801;8105.797355066171;8115.3913456491;8144.75565733029;6517.4134327910715;8096.352291816641;8102.918970810334;8117.878231826528;8125.187481251945;6321.715522801393;7789.753639417666;7833.882491762742;7840.215978402114;7840.980672512537;7436.219196984239;7671.309582137635;7676.155622881367;7686.730964416219;7688;8065.354771618374;8066.153053929253;8077.394195435249;8079.030516338077;8089.433739638169;4719.433667959866;4771;4783.928241076456;4788.11419887322;4789.30555069506;7506.58713770726;7763.61181940912;7793.961030194812;7797.649105790367;7858.017747781528;7471.701131954878;7498.062742157231;7505.8365953277325;7510.286522780327;7532.39740820744;7271.854562908818;7483.70065197386;7485.850282994201;7492;7496.512726672749;7275.927240727737;7282.927170728225;7284.854302913806;7298.306660867209;7319.817004574928;7470.468553946536;7491.8501629966;7502.21226771203;7502.399808015455;7521.5111017783665;7065.57606543609;7298.525595836254;7303.379212766974;7305.196428392766;7359.264073592812 10:19:39 INFO - 2015-11-24 10:19:39,404 DEBUG : BROWSER_OUTPUT: |5;yui.html;693.2391872981967;700.2157583506473;715.2954339975123;766.3562607409775;778.2373274191295;14689.192094434815;14939.850601493981;14974.700505989873;15007.774883376758;15047.548573542797;16424;16642.50072497827;16670.249838757256;16678.916605416987;16705.498835034967;756.7578374920027;769.1462476650913;942.2038377570941;948.9620415183384;971.6356366362614;956.5456408206117;957.3442192098435;958.2573505533198;964.7732782796037;967.9467629280387;1001.039002557542;1004.2518323848743;1010.9898901011006;1015.9796804063915;1018.8624535687661;988.574912787501;993.940363578184;994.9651762188289;1005.5324274212453;1005.7837564923576;736.4623824608012;742.4839736383216;742.5099434373287;748.1545853185919;749.9400047996147;15486.070835749892;15540.922295388451;15552.455664051817;15611.219439028117;15662.060276383454;12336.198147120409;12355.25868447887;12360.44378002992;12518.311492867888;12923.224606523545;8536.146385361477;9784.90215097847;10269.89730102697;10570.101541368917;10688.198385121146;2834.5323021701392;3132.1230055584474;3452.913677158091;3516.1561225306;3554.36021516127;83708.21063788337;84026.73959890606;85995;86303.99999999937;86403.56798216031;9497.192738617296;9530;9812.950935245279;9847.75380615476;10137;21423.57152856934;21487;21522.461938451663;21543.67684484734;21653.566928661337;7280.745173918994;7382.889256661155;7538.133114691771;7592.240775922474;7658.2341765824085;4001.0597509585223;4055.7972101395403;4125.030617804813;4135.110951145518;4254.510731265882;3438.914027149291;3451.775634583744;3463.2034632034774;3475.7045651119433;3478.513008178857;527.4777969809937;624.4816802054283;624.8781487609963;646.3019938466445;647.1748520636227;519.867433804385;544.8556132624858;597.8774351257981;598.6408155106901;605.1588292273743;8607.096254893146;8867.911320886838;9336.579853906454;9356.204722598655;9359.578818953163;516.7648719832467;540.7647673262144;580.7647902599454;612.9387061293924;627.8085184018827;4029.49631296088;4131.814068366931;4150.771707556053;4164.354525048622;4247.723897946686;78631;88561.55719221363;98502;99900.00099999053;100439;59080.40919590835;78056.82914756284;78860.6056969723;78961.60519197368;79000;68546;72518.27481725221;74279;74911.50176996429;75962.62018689871;8950.418222815757;9006.324525660733;9119.133682300171;9123.863142053007;9170;49058.77353066059;54833;55572.16641750296;55835.72082139563;55946.160807587105;68507.62984740378;72951.27048729657;76690.6165469169;78017.60991195234;79438;11377.2604780689;11403;11415.600453984403;11677.240979336317;12182.939085304517;10517.9474102629;12041.879581204075;12087.51649934028;12161.87838121643;12594.622161335175;9512.858456985206;9710.417374957526;11457.885421145682;11650.009749171415;11939.343336116597;11237.770397630347;11509.366984815915;11800.822987655363;11984.221025633306;12418.130730848754;11137.888621113685;11275.154363422613;11415.258008229439;11473.82789258145;12243.265404075784;9529.106782809093;9545.284103692113;9650.613975440903;9754.365966212174;10484.895151048391;9013.954930225307;9169.495677737788;10016.148627366756;10059.195264378686;10068.194544436281 10:19:39 INFO - 2015-11-24 10:19:39,404 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:19:39 INFO - 2015-11-24 10:19:39,404 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:19:39 INFO - 2015-11-24 10:19:39,405 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,350 10:19:39 INFO - 2015-11-24 10:19:39,405 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:19:39 INFO - 2015-11-24 10:19:39,405 DEBUG : BROWSER_OUTPUT: __startTimestamp1448389179389__endTimestamp 10:19:39 INFO - 2015-11-24 10:19:39,405 DEBUG : BROWSER_OUTPUT: 10:19:39 INFO - 2015-11-24 10:19:39,405 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:19:39 INFO - 2015-11-24 10:19:39,405 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:19:39 INFO - 2015-11-24 10:19:39,405 DEBUG : BROWSER_OUTPUT: 10:19:39 INFO - 2015-11-24 10:19:39,405 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5867.92 Median:6129.88 stddev:687.71 (11.2%) stddev-sans-first:649.83 10:19:39 INFO - 2015-11-24 10:19:39,405 DEBUG : BROWSER_OUTPUT: Values: 2922.3 3094.4 3434.0 3505.5 3556.5 4789.3 5899.4 5902.8 5905.6 5907.9 5759.0 5927.2 5933.3 5970.7 6059.0 5298.2 5312.2 5389.9 5458.5 5473.3 5452.0 5490.5 5513.8 5544.5 5545.5 5181.4 5195.2 5291.4 5447.0 5456.5 5336.8 5348.0 5358.0 5376.7 5394.3 5334.5 5342.8 5352.2 5353.6 5428.0 4171.8 5597.1 5920.0 5925.8 5987.8 6293.4 6301.8 6328.5 6352.6 6357.2 6360.6 6376.6 6381.0 6384.3 6385.3 5758.5 5923.2 6016.3 6082.2 6144.3 6394.4 6571.2 6571.8 6575.9 6581.9 6082.8 6356.5 6361.1 6374.5 6377.1 6213.3 6313.3 6361.0 6364.2 6484.6 6354.6 6359.8 6364.8 6374.4 6384.2 6347.2 6366.1 6374.8 6378.4 6383.2 4976.2 5062.6 5068.8 5107.1 5141.4 4578.1 4592.7 4601.7 4604.5 4630.5 5815.2 6008.1 6008.7 6057.7 6059.4 5392.9 6323.6 6329.9 6428.1 6448.7 5987.1 6022.2 6037.6 6059.1 6086.5 5404.3 5529.9 5627.2 5630.0 5634.0 5953.9 5965.3 6383.9 6484.7 6498.9 6361.7 6376.6 6416.0 6443.4 6448.3 6290.6 6388.0 6391.2 6583.2 6585.9 5333.3 6309.4 6343.1 6356.9 6374.7 5132.3 6365.5 6393.2 6415.1 6421.1 6139.4 6147.3 6213.9 6258.2 6308.5 5229.6 6306.5 6319.4 6321.9 6332.7 6148.9 6189.0 6194.7 6239.8 6276.7 6129.9 6193.7 6244.4 6265.2 6307.2 5183.5 6210.3 6265.8 6271.1 6277.3 10:19:39 INFO - 2015-11-24 10:19:39,405 DEBUG : BROWSER_OUTPUT: 10:19:39 INFO - 2015-11-24 10:19:39,405 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:59392.54 Median:21854.48 stddev:116580.43 (533.4%) stddev-sans-first:116823.76 10:19:39 INFO - 2015-11-24 10:19:39,407 DEBUG : BROWSER_OUTPUT: Values: 553.5 556.7 573.0 585.7 616.2 39924.6 40262.4 40432.4 40494.6 40569.8 43749.8 43882.6 43933.1 44322.3 44469.0 9711.5 9775.1 9844.0 9860.6 9908.1 9666.9 9729.8 9731.6 9787.8 9793.3 8474.4 9685.9 9731.8 9739.6 9787.9 9640.6 9679.7 9715.5 9729.2 9732.9 9596.6 9717.6 9721.0 9734.2 9768.4 40281.0 40444.4 40616.8 40655.0 40705.8 3270.4 3284.9 3322.8 3561.4 3784.4 28795.0 28837.8 29027.6 29077.9 29220.6 2738.7 2813.5 2822.9 2844.9 2958.1 484557.0 486225.0 486264.0 487368.0 488648.0 58339.1 59321.4 68487.0 69255.0 69294.7 67638.7 67696.0 67822.0 68093.0 68205.0 15633.4 15781.8 15788.3 15812.8 16009.0 12178.0 12187.7 12206.8 12220.7 12360.1 19885.5 19991.5 20052.0 20122.8 20128.8 8765.0 8959.3 9534.4 9608.0 9622.8 901.8 995.2 1050.2 1078.7 1087.6 29495.0 29777.9 29874.3 30372.5 30453.4 867.5 961.7 1095.8 1142.9 1270.5 14639.9 15218.5 15262.7 15520.6 15604.4 431047.0 464289.0 468252.0 468858.0 470484.0 57671.7 58358.7 58694.8 58972.7 59057.7 1176.0 1415.9 1436.4 1437.6 1449.1 29467.7 29694.9 30003.8 30177.8 30370.5 51305.7 51356.0 51652.2 51700.2 51764.0 361845.0 361891.0 362847.0 363480.0 363605.0 30359.4 32952.5 33415.3 33628.8 33866.8 42385.8 42747.6 42762.6 42833.4 43612.6 35372.3 35841.8 35937.0 36175.5 36460.6 34941.3 35385.0 35437.6 35599.3 35992.0 36044.5 36679.6 36705.0 36827.4 36945.1 26842.9 30888.7 32270.7 32334.4 32611.3 24906.4 25097.0 25231.0 25246.6 25571.6 10:19:39 INFO - 2015-11-24 10:19:39,407 DEBUG : BROWSER_OUTPUT: 10:19:39 INFO - 2015-11-24 10:19:39,407 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37285.58 Median:20370.39 stddev:118951.28 (583.9%) stddev-sans-first:119252.66 10:19:39 INFO - 2015-11-24 10:19:39,407 DEBUG : BROWSER_OUTPUT: Values: 358.9 365.0 366.4 367.4 367.5 15469.4 17904.8 19153.4 19572.3 20202.2 11391.5 11736.6 11756.5 11766.7 19474.6 5192.9 5200.2 5287.7 5306.5 5310.2 3882.9 4017.2 5266.3 5668.5 5841.0 5788.7 5808.0 5824.9 5832.9 5843.6 5973.4 6425.6 6426.3 6426.4 6448.5 5478.0 5605.9 5606.7 5640.0 5644.0 12199.0 13061.3 13148.3 13312.5 13318.1 1980.6 1990.8 2011.3 2022.4 2127.2 8448.9 9152.1 9661.8 9816.1 9921.9 1685.8 1706.3 1720.1 1771.9 1779.6 98717.5 100379.0 102188.0 103315.5 103911.0 10019.4 10160.2 10964.2 11105.9 11168.5 13121.3 13167.9 13190.8 13241.9 13254.0 7299.2 7862.9 8214.6 8294.9 8390.2 8190.1 8215.5 8249.8 8265.1 8269.0 4248.5 4254.2 4303.6 4331.2 4365.5 1745.9 1805.7 1806.8 1827.1 1870.0 914.6 943.3 1019.2 1035.3 1042.1 15759.0 17719.8 20025.2 20033.3 20406.9 419.3 432.4 434.6 448.4 455.5 5374.4 6004.3 6009.9 6082.5 6095.2 661229.0 711879.0 717863.8 738210.6 767625.0 93861.0 129568.0 130614.0 131164.3 133567.0 405.9 479.8 487.8 489.2 489.9 11037.3 11240.6 11255.1 11275.4 11311.0 55036.4 55315.0 55332.7 55960.7 56000.0 73639.0 73656.6 74410.3 75208.6 76907.6 10017.8 10116.6 10143.6 10212.5 10239.2 14580.6 15566.5 16557.9 17290.1 20333.9 13102.8 13695.8 15727.4 15757.3 16075.9 15232.9 15577.3 15714.8 15770.9 16004.2 7012.6 10831.0 16855.8 16943.3 17078.1 7562.8 9920.3 10113.9 10163.0 10181.6 15575.8 15722.5 16260.5 16278.2 16459.2 10:19:39 INFO - 2015-11-24 10:19:39,408 DEBUG : BROWSER_OUTPUT: 10:19:39 INFO - 2015-11-24 10:19:39,408 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5757.45 Median:6405.74 stddev:2980.24 (46.5%) stddev-sans-first:2972.05 10:19:39 INFO - 2015-11-24 10:19:39,409 DEBUG : BROWSER_OUTPUT: Values: 1578.6 1594.6 1609.5 1909.7 1939.8 6589.3 7426.9 8297.0 8459.3 8484.0 7926.8 8081.0 8169.6 8211.1 8226.3 2180.9 2205.4 2212.9 2220.0 2229.1 2338.2 2389.2 2416.6 2420.6 2430.1 2345.4 2360.0 2373.6 2381.3 2385.2 2341.7 2346.2 2360.9 2366.3 2377.6 2387.2 2395.8 2404.0 2410.6 2415.0 8261.0 8329.8 8338.2 8351.2 8352.9 4609.3 4873.7 5167.9 5190.8 5220.3 3162.6 3399.2 3425.8 3430.8 3479.5 1024.0 1039.6 1047.1 1050.6 1070.5 11012.1 11020.9 11025.1 11026.8 11067.4 4151.0 4486.8 4625.7 4726.1 4773.3 9495.4 9545.7 9552.5 9580.5 9598.1 5147.1 5167.7 5180.2 5180.3 5229.4 4677.8 4694.0 4701.4 4712.0 4738.0 3822.3 3880.0 3898.4 3911.9 3919.0 1291.1 1294.9 1295.5 1297.2 1307.0 1340.4 1360.0 1376.7 1376.9 1385.2 7660.5 7818.8 7832.3 7837.1 7840.7 486.8 487.4 490.8 494.2 505.9 6153.8 6173.3 6176.9 6199.8 6234.0 9570.7 9802.1 9895.1 9971.7 9983.8 8347.3 8381.0 9138.4 9905.0 9938.6 7676.7 7833.8 7869.9 7873.3 7913.1 7797.4 7825.3 7838.8 7844.7 7890.4 6706.0 8731.4 9119.3 9179.4 9191.0 9121.7 9374.8 9399.1 9420.0 9489.7 7338.9 7382.0 7407.9 7431.7 7435.5 7816.1 7930.7 7987.2 8005.4 8022.7 7459.3 7483.3 7501.2 7533.8 7630.5 7347.3 7374.6 7401.3 7482.8 7499.7 7475.3 7522.0 7575.1 7578.6 7582.2 6830.8 6842.1 6866.2 6905.8 6911.0 6316.7 6494.8 6762.2 6943.6 6946.8 10:19:39 INFO - 2015-11-24 10:19:39,409 DEBUG : BROWSER_OUTPUT: 10:19:39 INFO - 2015-11-24 10:19:39,409 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6034.70 Median:6899.41 stddev:1986.22 (28.8%) stddev-sans-first:1944.97 10:19:39 INFO - 2015-11-24 10:19:39,410 DEBUG : BROWSER_OUTPUT: Values: 322.6 326.6 332.5 336.2 336.2 5572.6 6790.2 6894.2 6984.5 6986.7 6704.2 6876.0 6915.5 6923.6 6970.4 5024.7 5041.6 5046.4 5047.1 5056.9 4879.7 5064.6 5070.8 5071.0 5076.8 4938.2 4962.3 4965.4 4970.6 4998.5 4945.5 4952.8 4955.2 4966.5 4973.1 4041.5 4118.8 4120.2 4206.9 4209.1 6570.7 6594.5 6612.2 6612.9 6622.8 5797.4 5878.3 5889.4 5895.3 5904.8 7147.5 7349.3 7350.2 7369.2 7391.9 4065.0 4709.5 4710.5 4713.9 4721.8 7075.5 7861.5 7863.9 7881.9 7892.2 4653.5 4763.9 4773.4 4777.1 4793.0 4870.0 4882.0 4889.6 4892.8 4902.4 5931.6 5938.6 5945.0 5948.6 5958.8 7290.3 7479.9 7530.7 7543.8 7558.2 1493.4 1605.9 1700.5 1702.6 1707.2 899.0 1073.6 1082.5 1087.4 1090.9 6231.0 6403.9 6910.3 6924.8 6927.5 6195.3 7742.4 7744.9 7769.7 7788.6 5680.6 6747.4 6904.7 6909.8 6919.4 3759.5 3797.4 3986.6 4058.8 4074.6 8072.9 8088.8 8109.7 8111.1 8116.4 7855.2 8100.6 8105.8 8115.4 8144.8 6517.4 8096.4 8102.9 8117.9 8125.2 6321.7 7789.8 7833.9 7840.2 7841.0 7436.2 7671.3 7676.2 7686.7 7688.0 8065.4 8066.2 8077.4 8079.0 8089.4 4719.4 4771.0 4783.9 4788.1 4789.3 7506.6 7763.6 7794.0 7797.6 7858.0 7471.7 7498.1 7505.8 7510.3 7532.4 7271.9 7483.7 7485.9 7492.0 7496.5 7275.9 7282.9 7284.9 7298.3 7319.8 7470.5 7491.9 7502.2 7502.4 7521.5 7065.6 7298.5 7303.4 7305.2 7359.3 10:19:39 INFO - 2015-11-24 10:19:39,410 DEBUG : BROWSER_OUTPUT: 10:19:39 INFO - 2015-11-24 10:19:39,410 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:18935.07 Median:55202.58 stddev:26668.41 (48.3%) stddev-sans-first:26708.04 10:19:39 INFO - 2015-11-24 10:19:39,412 DEBUG : BROWSER_OUTPUT: Values: 693.2 700.2 715.3 766.4 778.2 14689.2 14939.9 14974.7 15007.8 15047.5 16424.0 16642.5 16670.2 16678.9 16705.5 756.8 769.1 942.2 949.0 971.6 956.5 957.3 958.3 964.8 967.9 1001.0 1004.3 1011.0 1016.0 1018.9 988.6 993.9 995.0 1005.5 1005.8 736.5 742.5 742.5 748.2 749.9 15486.1 15540.9 15552.5 15611.2 15662.1 12336.2 12355.3 12360.4 12518.3 12923.2 8536.1 9784.9 10269.9 10570.1 10688.2 2834.5 3132.1 3452.9 3516.2 3554.4 83708.2 84026.7 85995.0 86304.0 86403.6 9497.2 9530.0 9813.0 9847.8 10137.0 21423.6 21487.0 21522.5 21543.7 21653.6 7280.7 7382.9 7538.1 7592.2 7658.2 4001.1 4055.8 4125.0 4135.1 4254.5 3438.9 3451.8 3463.2 3475.7 3478.5 527.5 624.5 624.9 646.3 647.2 519.9 544.9 597.9 598.6 605.2 8607.1 8867.9 9336.6 9356.2 9359.6 516.8 540.8 580.8 612.9 627.8 4029.5 4131.8 4150.8 4164.4 4247.7 78631.0 88561.6 98502.0 99900.0 100439.0 59080.4 78056.8 78860.6 78961.6 79000.0 68546.0 72518.3 74279.0 74911.5 75962.6 8950.4 9006.3 9119.1 9123.9 9170.0 49058.8 54833.0 55572.2 55835.7 55946.2 68507.6 72951.3 76690.6 78017.6 79438.0 11377.3 11403.0 11415.6 11677.2 12182.9 10517.9 12041.9 12087.5 12161.9 12594.6 9512.9 9710.4 11457.9 11650.0 11939.3 11237.8 11509.4 11800.8 11984.2 12418.1 11137.9 11275.2 11415.3 11473.8 12243.3 9529.1 9545.3 9650.6 9754.4 10484.9 9014.0 9169.5 10016.1 10059.2 10068.2 10:19:39 INFO - 2015-11-24 10:19:39,412 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:19:39 INFO - 2015-11-24 10:19:39,412 DEBUG : BROWSER_OUTPUT: 10:19:39 INFO - 2015-11-24 10:19:39,884 INFO : Browser exited with error code: 0 10:19:39 INFO - 2015-11-24 10:19:39,910 INFO : Completed test dromaeo_css (00:18:29) 10:19:39 INFO - 2015-11-24 10:19:39,910 INFO : Starting test kraken 10:19:39 INFO - 2015-11-24 10:19:39,910 DEBUG : operating with platform_type : mac_ 10:19:39 INFO - 2015-11-24 10:19:39,910 INFO : Initialising browser for kraken test... 10:19:39 INFO - 2015-11-24 10:19:39,923 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp4n1xys/profile http://localhost:52359/getInfo.html 10:19:42 INFO - 2015-11-24 10:19:42,723 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:19:42 INFO - 2015-11-24 10:19:42,723 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:19:42 INFO - 2015-11-24 10:19:42,723 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:19:42 INFO - 2015-11-24 10:19:42,723 DEBUG : BROWSER_OUTPUT: __metrics 10:19:43 INFO - 2015-11-24 10:19:43,321 INFO : Browser initialized. 10:19:43 INFO - 2015-11-24 10:19:43,322 INFO : Running cycle 1/1 for kraken test... 10:19:43 INFO - 2015-11-24 10:19:43,322 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp4n1xys/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:19:55 INFO - 2015-11-24 10:19:55,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 236281856 10:19:55 INFO - 2015-11-24 10:19:55,414 DEBUG : BROWSER_OUTPUT: 10:19:58 INFO - 2015-11-24 10:19:58,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52359/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:58 INFO - 2015-11-24 10:19:58,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 249847808 10:19:58 INFO - 2015-11-24 10:19:58,763 DEBUG : BROWSER_OUTPUT: 10:20:01 INFO - 2015-11-24 10:20:01,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52359/tests/kraken/driver.html?testName=audio-dft) 10:20:02 INFO - 2015-11-24 10:20:02,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 259366912 10:20:02 INFO - 2015-11-24 10:20:02,101 DEBUG : BROWSER_OUTPUT: 10:20:05 INFO - 2015-11-24 10:20:05,454 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52359/tests/kraken/driver.html?testName=audio-fft) 10:20:06 INFO - 2015-11-24 10:20:06,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 261742592 10:20:06 INFO - 2015-11-24 10:20:06,035 DEBUG : BROWSER_OUTPUT: 10:20:07 INFO - 2015-11-24 10:20:07,859 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52359/tests/kraken/driver.html?testName=audio-oscillator) 10:20:08 INFO - 2015-11-24 10:20:08,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 262909952 10:20:08 INFO - 2015-11-24 10:20:08,465 DEBUG : BROWSER_OUTPUT: 10:20:10 INFO - 2015-11-24 10:20:10,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52359/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:20:10 INFO - 2015-11-24 10:20:10,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 264404992 10:20:10 INFO - 2015-11-24 10:20:10,990 DEBUG : BROWSER_OUTPUT: 10:20:13 INFO - 2015-11-24 10:20:13,885 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52359/tests/kraken/driver.html?testName=imaging-darkroom) 10:20:14 INFO - 2015-11-24 10:20:14,480 DEBUG : BROWSER_OUTPUT: RSS: Main: 263229440 10:20:14 INFO - 2015-11-24 10:20:14,480 DEBUG : BROWSER_OUTPUT: 10:20:17 INFO - 2015-11-24 10:20:17,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52359/tests/kraken/driver.html?testName=imaging-desaturate) 10:20:18 INFO - 2015-11-24 10:20:18,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 264269824 10:20:18 INFO - 2015-11-24 10:20:18,101 DEBUG : BROWSER_OUTPUT: 10:20:20 INFO - 2015-11-24 10:20:20,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52359/tests/kraken/driver.html?testName=json-parse-financial) 10:20:21 INFO - 2015-11-24 10:20:21,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 265064448 10:20:21 INFO - 2015-11-24 10:20:21,579 DEBUG : BROWSER_OUTPUT: 10:20:23 INFO - 2015-11-24 10:20:23,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52359/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:23 INFO - 2015-11-24 10:20:23,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 264966144 10:20:23 INFO - 2015-11-24 10:20:23,681 DEBUG : BROWSER_OUTPUT: 10:20:25 INFO - 2015-11-24 10:20:25,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52359/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:26 INFO - 2015-11-24 10:20:26,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 265564160 10:20:26 INFO - 2015-11-24 10:20:26,180 DEBUG : BROWSER_OUTPUT: 10:20:28 INFO - 2015-11-24 10:20:28,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52359/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:28 INFO - 2015-11-24 10:20:28,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 265805824 10:20:28 INFO - 2015-11-24 10:20:28,824 DEBUG : BROWSER_OUTPUT: 10:20:31 INFO - 2015-11-24 10:20:31,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:32 INFO - 2015-11-24 10:20:32,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 265269248 10:20:32 INFO - 2015-11-24 10:20:32,041 DEBUG : BROWSER_OUTPUT: 10:20:34 INFO - 2015-11-24 10:20:34,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:35 INFO - 2015-11-24 10:20:35,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 265957376 10:20:35 INFO - 2015-11-24 10:20:35,066 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52359/tests/kraken/driver.html?testName=ai-astar) 10:20:36 INFO - 2015-11-24 10:20:36,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 266240000 10:20:36 INFO - 2015-11-24 10:20:36,940 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,940 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:20:36 INFO - 2015-11-24 10:20:36,940 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:20:36 INFO - 2015-11-24 10:20:36,940 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:20:36 INFO - 2015-11-24 10:20:36,940 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:20:36 INFO - 2015-11-24 10:20:36,940 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;103;113;125;167;130;122;164;115;115 10:20:36 INFO - 2015-11-24 10:20:36,940 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;127;163;184;109;161;174;150;166;148 10:20:36 INFO - 2015-11-24 10:20:36,940 DEBUG : BROWSER_OUTPUT: |2;audio-dft;197;195;192;207;223;204;180;272;261;198 10:20:36 INFO - 2015-11-24 10:20:36,940 DEBUG : BROWSER_OUTPUT: |3;audio-fft;67;60;70;112;57;58;59;59;113;59 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;76;77;108;74;76;80;119;77;78;93 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;79;126;133;115;87;78;132;90;97;89 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;151;132;94;134;107;96;96;104;95;115 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;93;93;92;91;91;93;95;138;145;115 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;61;59;59;59;61;52;59;61;61 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;66;66;82;67;66;65;68;68;85;103 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;83;85;84;86;84;84;85;88;87 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;143;122;121;134;131;135;130;127;134;113 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;141;137;139;139;139;140;139;135;140 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;67;66;66;66;67;66;69;68 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,829 10:20:36 INFO - 2015-11-24 10:20:36,941 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:20:36 INFO - 2015-11-24 10:20:36,942 DEBUG : BROWSER_OUTPUT: __startTimestamp1448389236937__endTimestamp 10:20:36 INFO - 2015-11-24 10:20:36,942 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,943 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:20:36 INFO - 2015-11-24 10:20:36,943 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:20:36 INFO - 2015-11-24 10:20:36,943 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,943 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:126.70 Median:123.50 stddev:21.76 (17.6%) stddev-sans-first:22.51 10:20:36 INFO - 2015-11-24 10:20:36,943 DEBUG : BROWSER_OUTPUT: Values: 113.0 103.0 113.0 125.0 167.0 130.0 122.0 164.0 115.0 115.0 10:20:36 INFO - 2015-11-24 10:20:36,944 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,944 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:153.00 Median:162.00 stddev:22.13 (13.7%) stddev-sans-first:23.39 10:20:36 INFO - 2015-11-24 10:20:36,944 DEBUG : BROWSER_OUTPUT: Values: 148.0 127.0 163.0 184.0 109.0 161.0 174.0 150.0 166.0 148.0 10:20:36 INFO - 2015-11-24 10:20:36,944 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,944 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:212.90 Median:205.50 stddev:30.44 (14.8%) stddev-sans-first:31.73 10:20:36 INFO - 2015-11-24 10:20:36,944 DEBUG : BROWSER_OUTPUT: Values: 197.0 195.0 192.0 207.0 223.0 204.0 180.0 272.0 261.0 198.0 10:20:36 INFO - 2015-11-24 10:20:36,944 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,944 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:71.40 Median:59.00 stddev:22.06 (37.4%) stddev-sans-first:23.34 10:20:36 INFO - 2015-11-24 10:20:36,944 DEBUG : BROWSER_OUTPUT: Values: 67.0 60.0 70.0 112.0 57.0 58.0 59.0 59.0 113.0 59.0 10:20:36 INFO - 2015-11-24 10:20:36,944 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:85.80 Median:77.00 stddev:15.73 (20.4%) stddev-sans-first:16.28 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: Values: 76.0 77.0 108.0 74.0 76.0 80.0 119.0 77.0 78.0 93.0 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:83.00 stddev:21.78 (26.2%) stddev-sans-first:21.36 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: Values: 79.0 126.0 133.0 115.0 87.0 78.0 132.0 90.0 97.0 89.0 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:112.40 Median:122.50 stddev:20.07 (16.4%) stddev-sans-first:15.70 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: Values: 151.0 132.0 94.0 134.0 107.0 96.0 96.0 104.0 95.0 115.0 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:104.60 Median:92.50 stddev:20.76 (22.4%) stddev-sans-first:21.60 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 92.0 91.0 91.0 93.0 95.0 138.0 145.0 115.0 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,945 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.10 Median:60.00 stddev:2.69 (4.5%) stddev-sans-first:2.85 10:20:36 INFO - 2015-11-24 10:20:36,946 DEBUG : BROWSER_OUTPUT: Values: 59.0 61.0 59.0 59.0 59.0 61.0 52.0 59.0 61.0 61.0 10:20:36 INFO - 2015-11-24 10:20:36,946 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,946 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:67.50 stddev:12.55 (18.6%) stddev-sans-first:13.01 10:20:36 INFO - 2015-11-24 10:20:36,946 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 82.0 67.0 66.0 65.0 68.0 68.0 85.0 103.0 10:20:36 INFO - 2015-11-24 10:20:36,946 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,946 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:1.64 (1.9%) stddev-sans-first:1.62 10:20:36 INFO - 2015-11-24 10:20:36,947 DEBUG : BROWSER_OUTPUT: Values: 87.0 83.0 85.0 84.0 86.0 84.0 84.0 85.0 88.0 87.0 10:20:36 INFO - 2015-11-24 10:20:36,947 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,947 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.00 Median:132.50 stddev:8.56 (6.5%) stddev-sans-first:7.43 10:20:36 INFO - 2015-11-24 10:20:36,947 DEBUG : BROWSER_OUTPUT: Values: 143.0 122.0 121.0 134.0 131.0 135.0 130.0 127.0 134.0 113.0 10:20:36 INFO - 2015-11-24 10:20:36,947 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,948 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.20 Median:139.50 stddev:2.15 (1.5%) stddev-sans-first:1.79 10:20:36 INFO - 2015-11-24 10:20:36,948 DEBUG : BROWSER_OUTPUT: Values: 143.0 141.0 137.0 139.0 139.0 139.0 140.0 139.0 135.0 140.0 10:20:36 INFO - 2015-11-24 10:20:36,948 DEBUG : BROWSER_OUTPUT: 10:20:36 INFO - 2015-11-24 10:20:36,948 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.05 (1.6%) stddev-sans-first:1.05 10:20:36 INFO - 2015-11-24 10:20:36,948 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 67.0 66.0 66.0 66.0 67.0 66.0 69.0 68.0 10:20:36 INFO - 2015-11-24 10:20:36,948 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:20:36 INFO - 2015-11-24 10:20:36,948 DEBUG : BROWSER_OUTPUT: 10:20:37 INFO - 2015-11-24 10:20:37,575 INFO : Browser exited with error code: 0 10:20:37 INFO - 2015-11-24 10:20:37,622 INFO : Completed test kraken (00:00:57) 10:20:37 INFO - 2015-11-24 10:20:37,622 INFO : Starting test v8_7 10:20:37 INFO - 2015-11-24 10:20:37,622 DEBUG : operating with platform_type : mac_ 10:20:37 INFO - 2015-11-24 10:20:37,623 INFO : Initialising browser for v8_7 test... 10:20:37 INFO - 2015-11-24 10:20:37,636 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpcQ3jKY/profile http://localhost:52359/getInfo.html 10:20:40 INFO - 2015-11-24 10:20:40,165 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:20:40 INFO - 2015-11-24 10:20:40,165 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:20:40 INFO - 2015-11-24 10:20:40,165 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 10:20:40 INFO - 2015-11-24 10:20:40,165 DEBUG : BROWSER_OUTPUT: __metrics 10:20:40 INFO - 2015-11-24 10:20:40,774 INFO : Browser initialized. 10:20:40 INFO - 2015-11-24 10:20:40,774 INFO : Running cycle 1/1 for v8_7 test... 10:20:40 INFO - 2015-11-24 10:20:40,775 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpcQ3jKY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:20:52 INFO - 2015-11-24 10:20:52,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 238456832 10:20:52 INFO - 2015-11-24 10:20:52,752 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52359/tests/v8_7/run.html (next: http://localhost:52359/tests/v8_7/run.html) 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 248131584 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: |0;Richards;178.9549033643522 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.72754391779912 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.4467120181406 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4794.258373205742 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: |4;RayTrace;948.7666034155598 10:21:14 INFO - 2015-11-24 10:21:14,361 DEBUG : BROWSER_OUTPUT: |5;Earley;720.9805335255949 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: |6;Boyer;16129.032258064517 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: |8;Splay;769.2307692307693 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4921.568627450981 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: __startTimestamp1448389274354__endTimestamp 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:178.95 Median:178.95 stddev:0.00 (0.0%) 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: Values: 179.0 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,362 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.73 Median:165.73 stddev:0.00 (0.0%) 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: Values: 165.7 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.45 Median:283.45 stddev:0.00 (0.0%) 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: Values: 283.4 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4794.26 Median:4794.26 stddev:0.00 (0.0%) 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: Values: 4794.3 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:948.77 Median:948.77 stddev:0.00 (0.0%) 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: Values: 948.8 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:720.98 Median:720.98 stddev:0.00 (0.0%) 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: Values: 721.0 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16129.03 Median:16129.03 stddev:0.00 (0.0%) 10:21:14 INFO - 2015-11-24 10:21:14,363 DEBUG : BROWSER_OUTPUT: Values: 16129.0 10:21:14 INFO - 2015-11-24 10:21:14,364 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,364 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 10:21:14 INFO - 2015-11-24 10:21:14,364 DEBUG : BROWSER_OUTPUT: Values: 27027.0 10:21:14 INFO - 2015-11-24 10:21:14,364 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,364 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:769.23 Median:769.23 stddev:0.00 (0.0%) 10:21:14 INFO - 2015-11-24 10:21:14,364 DEBUG : BROWSER_OUTPUT: Values: 769.2 10:21:14 INFO - 2015-11-24 10:21:14,364 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,364 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4921.57 Median:4921.57 stddev:0.00 (0.0%) 10:21:14 INFO - 2015-11-24 10:21:14,364 DEBUG : BROWSER_OUTPUT: Values: 4921.6 10:21:14 INFO - 2015-11-24 10:21:14,364 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:21:14 INFO - 2015-11-24 10:21:14,364 DEBUG : BROWSER_OUTPUT: 10:21:14 INFO - 2015-11-24 10:21:14,959 INFO : Browser exited with error code: 0 10:21:14 INFO - 2015-11-24 10:21:14,973 INFO : Completed test v8_7 (00:00:37) 10:21:14 INFO - 2015-11-24 10:21:14,992 INFO : Completed test suite (00:20:05) 10:21:14 INFO - 2015-11-24 10:21:14,992 DEBUG : Working with test: dromaeo_css 10:21:14 INFO - 2015-11-24 10:21:14,992 DEBUG : Generating results file: dromaeo_css 10:21:14 INFO - 2015-11-24 10:21:14,993 DEBUG : Working with test: kraken 10:21:14 INFO - 2015-11-24 10:21:14,993 DEBUG : Generating results file: kraken 10:21:14 INFO - 2015-11-24 10:21:14,994 INFO : javascript benchmark 10:21:14 INFO - 2015-11-24 10:21:14,994 DEBUG : Working with test: v8_7 10:21:14 INFO - 2015-11-24 10:21:14,994 DEBUG : Generating results file: v8_7 10:21:14 INFO - 2015-11-24 10:21:14,994 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:15 INFO - 2015-11-24 10:21:15,586 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 10:21:15 INFO - 2015-11-24 10:21:15,586 DEBUG : process_Request line: dromaeo_css 7510.78 graph.html#tests=[[72,64,61]] 10:21:15 INFO - 2015-11-24 10:21:15,586 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:15 INFO - 2015-11-24 10:21:15,624 DEBUG : process_Request line: kraken 1522.60 graph.html#tests=[[232,64,61]] 10:21:15 INFO - 2015-11-24 10:21:15,624 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:21:15 INFO - 2015-11-24 10:21:15,755 DEBUG : process_Request line: v8_7 20603.55 graph.html#tests=[[230,64,61]] 10:21:15 INFO - 2015-11-24 10:21:15,756 INFO : javascript benchmark 10:21:15 INFO - 2015-11-24 10:21:15,760 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2922.2840404100984, 3094.443000259954, 3434.0, 3505.526753888226, 3556.4843097750845, 4789.281607758833, 5899.439553242435, 5902.822915312537, 5905.61613495123, 5907.88184236315, 5758.971205143968, 5927.229460170182, 5933.3473317934995, 5970.73131709073, 6059.0, 5298.23175639532, 5312.1766126250495, 5389.946100539003, 5458.5087342139195, 5473.261109750192, 5451.972740136293, 5490.505854473096, 5513.8345849624575, 5544.500994910457, 5545.473180047909, 5181.35233095863, 5195.246689230078, 5291.417944026154, 5446.992306423324, 5456.48163424476, 5336.839894803124, 5348.010618035637, 5357.973210133924, 5376.731163441812, 5394.32570928634, 5334.519893209591, 5342.813001544927, 5352.170413585901, 5353.625246232766, 5427.972860135674, 4171.770552619605, 5597.104463285855, 5920.0, 5925.822225333247, 5987.790427335022, 6293.370662933716, 6301.8109456716375, 6328.493720502349, 6352.555321127523, 6357.237131544198, 6360.55476116672, 6376.6174029557915, 6381.0, 6384.297727249998, 6385.297617262097, 5758.481736643722, 5923.229980102602, 6016.308124565643, 6082.1789058477425, 6144.324124346318, 6394.360563943568, 6571.244306904767, 6571.769988050491, 6575.901361479581, 6581.901271480931, 6082.787102451482, 6356.523260755462, 6361.109444677749, 6374.458171055512, 6377.107204991305, 6213.285472170668, 6313.337099604567, 6361.0, 6364.236291644939, 6484.578502397329, 6354.586951848115, 6359.841003974845, 6364.84087897797, 6374.426301632875, 6384.170057892445, 6347.174867267318, 6366.140571022946, 6374.808755737336, 6378.394052564999, 6383.202099737533, 4976.2038073908, 5062.594992400599, 5068.847934561895, 5107.055194788976, 5141.357330333708, 4578.061497393026, 4592.724436533818, 4601.723896566216, 4604.539546045368, 4630.53694630541, 5815.244018277597, 6008.128821320972, 6008.669523176267, 6057.666828324484, 6059.394060593993, 5392.91910621341, 6323.5573509854785, 6329.936700632935, 6428.132202152743, 6448.709808058648, 5987.1318658794235, 6022.247219097613, 6037.577369584174, 6059.121427393092, 6086.543509236825, 5404.29744133268, 5529.889402211933, 5627.212190293362, 5630.014747419185, 5633.971830140823, 5953.851153721105, 5965.34381218057, 6383.904241436382, 6484.708188131545, 6498.870022599522, 6361.745530178741, 6376.553641245068, 6416.037594360883, 6443.420092191725, 6448.258450278278, 6290.559660823698, 6388.009858471944, 6391.201099862517, 6583.242927063257, 6585.901211481736, 5333.306670132858, 6309.400606942333, 6343.111964324906, 6356.904646430215, 6374.74501019954, 5132.325566307462, 6365.52258580599, 6393.1688880445245, 6415.069814876723, 6421.101045853491, 6139.386061393825, 6147.293061297829, 6213.9067913982235, 6258.155149055002, 6308.495320374451, 5229.555487783429, 6306.527010474141, 6319.368063193644, 6321.8735625288155, 6332.683365831782, 6148.907766383597, 6188.9788184948975, 6194.659293738888, 6239.844003899939, 6276.748930042747, 6129.8784197560135, 6193.690315484298, 6244.406781355764, 6265.248170219603, 6307.180066591313, 5183.481651834786, 6210.3168651449205, 6265.843353916189, 6271.122042913905, 6277.340879207617], "unit": "ms", "name": "dojo.html", "value": 5824.753120734162}, {"lowerIsBetter": false, "replicates": [553.4500974110941, 556.7272036702017, 573.0458786121109, 585.7217821534769, 616.214326733415, 39924.60075399249, 40262.39606405899, 40432.393514097275, 40494.59505404945, 40569.78290651282, 43749.78125109378, 43882.56117438825, 43933.121337573306, 44322.33516497255, 44469.0, 9711.514424278776, 9775.120239178472, 9843.950780246088, 9860.556274967608, 9908.058734420218, 9666.854997175047, 9729.756756081084, 9731.610735570568, 9787.755306117333, 9793.265505087147, 8474.406791524596, 9685.854712179324, 9731.756706082333, 9739.561719722595, 9787.853182202272, 9640.61437542501, 9679.70960871175, 9715.46564938928, 9729.221662267037, 9732.854007189897, 9596.568154433067, 9717.61129554817, 9721.0, 9734.221262299, 9768.36505627132, 40281.0, 40444.393334100016, 40616.79691601523, 40655.0, 40705.796471017755, 3270.3622793555264, 3284.8850290239966, 3322.7840190387788, 3561.3767590671528, 3784.3566593678866, 28795.0, 28837.8278389377, 29027.564586531218, 29077.854610727023, 29220.561691574643, 2738.7261273872455, 2813.535766598509, 2822.8729707163225, 2844.937465147779, 2958.082994271783, 484557.0, 486224.99999999645, 486264.0, 487368.0, 488648.0, 58339.12491312634, 59321.40678593245, 68487.0, 69255.0, 69294.65352673204, 67638.66180669065, 67696.0, 67822.0, 68092.97860532095, 68205.0, 15633.374665013273, 15781.842181578037, 15788.289526971314, 15812.762808557882, 16009.0, 12177.990631545696, 12187.695307617381, 12206.755864882653, 12220.694482638006, 12360.134790564754, 19885.502862428264, 19991.500212494804, 20052.0, 20122.798772012386, 20128.798712012693, 8765.035846056928, 8959.328050396116, 9534.427934323963, 9607.951960240154, 9622.807543849083, 901.8196360727881, 995.2485873165714, 1050.1808589300358, 1078.719532921446, 1087.5867170475326, 29495.0, 29777.85111074431, 29874.253143671147, 30372.544411833842, 30453.39093218123, 867.5185272174004, 961.7018724195522, 1095.8137116690182, 1142.8857114288671, 1270.4981532294692, 14639.853601463848, 15218.467353642569, 15262.694746105015, 15520.611984700246, 15604.375824966874, 431047.0, 464289.0, 468252.0, 468858.0, 470484.0, 57671.71164144152, 58358.708206459545, 58694.82610347769, 58972.70513647404, 59057.704711476166, 1175.9823602645968, 1415.9079659822078, 1436.4182506084844, 1437.6190309567974, 1449.0725935401351, 29467.705322946495, 29694.851525742233, 30003.849980749957, 30177.7928882851, 30370.544441833834, 51305.7434712824, 51356.0, 51652.22521662253, 51700.22449663333, 51764.0, 361845.0, 361891.0, 362847.0, 363480.0, 363605.0, 30359.392812144077, 32952.505712413855, 33415.33169336648, 33628.831855840566, 33866.830665846515, 42385.788071060684, 42747.5725242756, 42762.57237427586, 42833.357499636906, 43612.56387436085, 35372.29255414929, 35841.82079089588, 35937.0, 36175.457368138974, 36460.63539364572, 34941.30117397587, 35385.0, 35437.64562354344, 35599.28801424009, 35992.0, 36044.4593331095, 36679.633203667625, 36705.0, 36827.447588285664, 36945.07637309089, 26842.926282949244, 30888.69111308948, 32270.677293226767, 32334.35331293408, 32611.34777304488, 24906.377340566632, 25097.0, 25231.0, 25246.621300680137, 25571.616425754], "unit": "ms", "name": "ext.html", "value": 19726.587895020006}, {"lowerIsBetter": false, "replicates": [358.9138606734385, 364.9927001459971, 366.38264524276593, 367.3754617150841, 367.481850590667, 15469.381224750996, 17904.82095179048, 19153.425397238072, 19572.31496897609, 20202.19191232351, 11391.54433822646, 11736.647900562975, 11756.529738810437, 11766.705662377131, 19474.610507789872, 5192.8701782455555, 5200.245964335169, 5287.656302340355, 5306.495882891119, 5310.176922577007, 3882.9223415531674, 4017.216642754664, 5266.262723218752, 5668.518175955049, 5840.970795146019, 5788.710564471759, 5808.041673123929, 5824.912626310587, 5832.883342333151, 5843.64938103713, 5973.432523910222, 6425.58233714807, 6426.2931077581425, 6426.421622054014, 6448.548601597867, 5478.0, 5605.915911261334, 5606.691631960241, 5639.971800141014, 5644.040513112781, 12199.0, 13061.281629510373, 13148.342582870913, 13312.534061307904, 13318.067735258535, 1980.5939782344728, 1990.8307793837541, 2011.3463124484456, 2022.3629556689743, 2127.181035301405, 8448.915510844936, 9152.130547598033, 9661.758456038586, 9816.116549510507, 9921.90078099217, 1685.7639930409753, 1706.2742368499478, 1720.096949101719, 1771.8936863788085, 1779.6070945677307, 98717.53206169831, 100379.0, 102188.0, 103315.4834225824, 103911.0, 10019.448930308903, 10160.187185025181, 10964.17768667353, 11105.944470277758, 11168.497417616227, 13121.343932803513, 13167.934160329138, 13190.802137967938, 13241.933790330986, 13254.0, 7299.19708832028, 7862.921370786219, 8214.58927053645, 8294.875576866352, 8390.244877961013, 8190.058143313595, 8215.548144852091, 8249.79375515617, 8265.132161122996, 8268.958655206685, 4248.511421186541, 4254.170436764863, 4303.569643035734, 4331.242032644274, 4365.476142862877, 1745.8952462852014, 1805.6569251842109, 1806.8102849200907, 1827.077325950413, 1869.9719504207449, 914.5884352041475, 943.297243553557, 1019.2202964731986, 1035.254616675992, 1042.0777611813598, 15759.0, 17719.822801772076, 20025.198992040445, 20033.29883454072, 20406.897965510376, 419.2746548471162, 432.3557898730931, 434.56326391975864, 448.4349719353573, 455.464828826128, 5374.435684253175, 6004.279486461653, 6009.939900601025, 6082.452579267887, 6095.238095238095, 661229.0, 711879.0, 717863.8213617902, 738210.6178938249, 767625.0, 93861.0, 129568.0, 130614.0, 131164.34417828041, 133567.0, 405.94925634295714, 479.7721082485791, 487.8024400117958, 489.1903899047083, 489.87573518773786, 11037.337759734442, 11240.606578769704, 11255.099592032782, 11275.436228188722, 11311.038561722016, 55036.44963550313, 55315.0, 55332.72333638467, 55960.72019639876, 56000.0, 73639.0, 73656.63171684108, 74410.25589744034, 75208.62395688206, 76907.61546192234, 10017.849732254168, 10116.645917392856, 10143.64497242593, 10212.540435680561, 10239.18086553059, 14580.635484112981, 15566.533004009898, 16557.91721041387, 17290.13549322554, 20333.881636510134, 13102.75523825235, 13695.794563081363, 15727.370905164124, 15757.29092190877, 16075.919620401823, 15232.923835380752, 15577.299021543831, 15714.842851571795, 15770.92114539466, 16004.19979001022, 7012.649367531705, 10831.0, 16855.831441685426, 16943.32226710918, 17078.060706661254, 7562.810929726801, 9920.255980801325, 10113.89886101159, 10163.034511721375, 10181.592736290466, 15575.844241557892, 15722.528324150293, 16260.51218463448, 16278.186090695655, 16459.177041147654], "unit": "ms", "name": "jquery.html", "value": 8845.907489669606}, {"lowerIsBetter": false, "replicates": [1578.558003758948, 1594.5933786884343, 1609.5171448565427, 1909.713542968555, 1939.825415712586, 6589.341065893408, 7426.925730742691, 8297.045839728426, 8459.32325413967, 8484.0, 7926.841463170733, 8081.0, 8169.59152042397, 8211.137830527798, 8226.259636632702, 2180.858244214125, 2205.448637840532, 2212.9114835406563, 2219.9556008879813, 2229.1306390507716, 2338.1933233034574, 2389.175734371639, 2416.6495858100566, 2420.6127019676856, 2430.052279610953, 2345.4253707841604, 2359.9646005309933, 2373.5964885969343, 2381.2618088392655, 2385.1651921827397, 2341.7424083350816, 2346.155384061736, 2360.893759780814, 2366.3137690069857, 2377.5839228135005, 2387.1883559589824, 2395.772401621843, 2403.97596024041, 2410.602250628644, 2414.99777592299, 8260.958695206546, 8329.791755206108, 8338.24955753979, 8351.24838764508, 8352.916470835275, 4609.262517997138, 4873.658843880929, 5167.896642067138, 5190.844274671728, 5220.26916231724, 3162.588863447737, 3399.184195792992, 3425.760196786226, 3430.794152350842, 3479.495473156378, 1023.9846402303972, 1039.6101461951769, 1047.0524175621076, 1050.5535147562255, 1070.4861666400172, 11012.063974562092, 11020.944895275472, 11025.117990560735, 11026.834597480964, 11067.391293478855, 4151.024509240327, 4486.842960496432, 4625.699329543569, 4726.078414709099, 4773.284007398918, 9495.43027418357, 9545.665901693408, 9552.522373881278, 9580.520973951274, 9598.088181622734, 5147.073526765218, 5167.689938603696, 5180.1711726124395, 5180.32655754757, 5229.424763276036, 4677.812887484531, 4693.953060469352, 4701.412323459567, 4711.976440117777, 4737.95262047382, 3822.2737679840743, 3879.9718074710227, 3898.3567711327314, 3911.882643520699, 3919.0, 1291.063978615515, 1294.9417276222594, 1295.488282128554, 1297.241113948332, 1306.9738605228033, 1340.3700260877372, 1359.952401665937, 1376.6558360409897, 1376.8967327450482, 1385.2173521960262, 7660.540367577852, 7818.804529886685, 7832.334251588565, 7837.1379148293645, 7840.686372545034, 486.79068000759304, 487.4370102531582, 490.80122550367156, 494.22900275570225, 505.86847419671153, 6153.815385538441, 6173.32093469718, 6176.938230617726, 6199.814005579839, 6234.0337247726675, 9570.665026724171, 9802.117809397188, 9895.109440150278, 9971.700848974542, 9983.750406239902, 8347.332213422911, 8381.0, 9138.360314777901, 9904.950475247577, 9938.552765125587, 7676.731314403969, 7833.764987050397, 7869.921300787033, 7873.25204105609, 7913.061299981541, 7797.415193860596, 7825.256600622932, 7838.843223135619, 7844.725434609762, 7890.408219383455, 6706.0, 8731.388802783744, 9119.316051296311, 9179.44923304577, 9190.988991211096, 9121.680741174026, 9374.81250374975, 9399.060093990547, 9419.952900235729, 9489.66786162481, 7338.853222935405, 7382.0, 7407.851842963219, 7431.665575049027, 7435.4795164337975, 7816.06207255133, 7930.722424715107, 7987.201279871966, 8005.359571234404, 8022.679092836454, 7459.328660420588, 7483.289087536676, 7501.212372701006, 7533.849323013618, 7630.465867389452, 7347.302006309392, 7374.594397308199, 7401.259874012556, 7482.775516734507, 7499.737509187153, 7475.289847464483, 7522.0, 7575.128860180929, 7578.621068946641, 7582.241775822374, 6830.829229269308, 6842.110525631636, 6866.1760588727675, 6905.792826215222, 6911.0, 6316.7157477914525, 6494.772682956074, 6762.154730658668, 6943.583384996714, 6946.79159625212], "unit": "ms", "name": "mootools.html", "value": 4657.011936449913}, {"lowerIsBetter": false, "replicates": [322.617698027837, 326.5787134596371, 332.54607460815987, 336.1948134218545, 336.21829247000727, 5572.637778544392, 6790.219124800649, 6894.172699276094, 6984.546004509703, 6986.6855991480315, 6704.161979752531, 6876.0, 6915.51591388603, 6923.619200943946, 6970.442364610832, 5024.673396229252, 5041.571466425358, 5046.369203849519, 5047.0915235257635, 5056.938043010954, 4879.682820616648, 5064.55660136861, 5070.822521211759, 5071.0, 5076.796928122871, 4938.16051271283, 4962.330085438456, 4965.404151501807, 4970.627202959774, 4998.450170481244, 4945.530174633422, 4952.826651067214, 4955.157623204064, 4966.453690094087, 4973.129702302101, 4041.4948131483566, 4118.814653340577, 4120.175964807021, 4206.91586168278, 4209.137126888981, 6570.671466426707, 6594.472442204612, 6612.206535215805, 6612.900806487906, 6622.801315960529, 5797.391273916221, 5878.294604647427, 5889.381614930414, 5895.263092113486, 5904.763809447617, 7147.53541019832, 7349.338559529615, 7350.228226036296, 7369.152547457057, 7391.85216295671, 4064.9593504065174, 4709.458412282563, 4710.505396933307, 4713.882152946169, 4721.787519561628, 7075.504714669975, 7861.48900321483, 7863.882041769378, 7881.881771773428, 7892.171322011163, 4653.511381304982, 4763.904721905543, 4773.427188737304, 4777.116233496814, 4792.95207047932, 4869.95130048695, 4882.048000639912, 4889.633277504201, 4892.755362231874, 4902.362692849907, 5931.584789064724, 5938.6139900907165, 5945.048792193228, 5948.5538584605465, 5958.761649534057, 7290.3438690518105, 7479.915412265191, 7530.6611202496015, 7543.755280378786, 7558.168601453835, 1493.402638944431, 1605.9357625695075, 1700.4558541266676, 1702.6339337042596, 1707.2061491406555, 898.9730308090637, 1073.5759375046969, 1082.5128692088592, 1087.363892123101, 1090.8636420447444, 6231.003039513656, 6403.879321118786, 6910.274421185703, 6924.792256232321, 6927.480438966997, 6195.349488303754, 7742.4193185510185, 7744.883826742604, 7769.650365733442, 7788.649510772028, 5680.573956953245, 6747.392734653905, 6904.654767261617, 6909.827254318581, 6919.411849992706, 3759.548854137466, 3797.35444974355, 3986.6412022918075, 4058.776767277769, 4074.6129117733767, 8072.878906816402, 8088.797780055428, 8109.675612975533, 8111.107778144399, 8116.391270654724, 7855.175206603339, 8100.635471403801, 8105.797355066171, 8115.3913456491, 8144.75565733029, 6517.4134327910715, 8096.352291816641, 8102.918970810334, 8117.878231826528, 8125.187481251945, 6321.715522801393, 7789.753639417666, 7833.882491762742, 7840.215978402114, 7840.980672512537, 7436.219196984239, 7671.309582137635, 7676.155622881367, 7686.730964416219, 7688.0, 8065.354771618374, 8066.153053929253, 8077.394195435249, 8079.030516338077, 8089.433739638169, 4719.433667959866, 4771.0, 4783.928241076456, 4788.11419887322, 4789.30555069506, 7506.58713770726, 7763.61181940912, 7793.961030194812, 7797.649105790367, 7858.017747781528, 7471.701131954878, 7498.062742157231, 7505.8365953277325, 7510.286522780327, 7532.39740820744, 7271.854562908818, 7483.70065197386, 7485.850282994201, 7492.0, 7496.512726672749, 7275.927240727737, 7282.927170728225, 7284.854302913806, 7298.306660867209, 7319.817004574928, 7470.468553946536, 7491.8501629966, 7502.21226771203, 7502.399808015455, 7521.5111017783665, 7065.57606543609, 7298.525595836254, 7303.379212766974, 7305.196428392766, 7359.264073592812], "unit": "ms", "name": "prototype.html", "value": 5358.345000592502}, {"lowerIsBetter": false, "replicates": [693.2391872981967, 700.2157583506473, 715.2954339975123, 766.3562607409775, 778.2373274191295, 14689.192094434815, 14939.850601493981, 14974.700505989873, 15007.774883376758, 15047.548573542797, 16424.0, 16642.50072497827, 16670.249838757256, 16678.916605416987, 16705.498835034967, 756.7578374920027, 769.1462476650913, 942.2038377570941, 948.9620415183384, 971.6356366362614, 956.5456408206117, 957.3442192098435, 958.2573505533198, 964.7732782796037, 967.9467629280387, 1001.039002557542, 1004.2518323848743, 1010.9898901011006, 1015.9796804063915, 1018.8624535687661, 988.574912787501, 993.940363578184, 994.9651762188289, 1005.5324274212453, 1005.7837564923576, 736.4623824608012, 742.4839736383216, 742.5099434373287, 748.1545853185919, 749.9400047996147, 15486.070835749892, 15540.922295388451, 15552.455664051817, 15611.219439028117, 15662.060276383454, 12336.198147120409, 12355.25868447887, 12360.44378002992, 12518.311492867888, 12923.224606523545, 8536.146385361477, 9784.90215097847, 10269.89730102697, 10570.101541368917, 10688.198385121146, 2834.5323021701392, 3132.1230055584474, 3452.913677158091, 3516.1561225306, 3554.36021516127, 83708.21063788337, 84026.73959890606, 85995.0, 86303.99999999937, 86403.56798216031, 9497.192738617296, 9530.0, 9812.950935245279, 9847.75380615476, 10137.0, 21423.57152856934, 21487.0, 21522.461938451663, 21543.67684484734, 21653.566928661337, 7280.745173918994, 7382.889256661155, 7538.133114691771, 7592.240775922474, 7658.2341765824085, 4001.0597509585223, 4055.7972101395403, 4125.030617804813, 4135.110951145518, 4254.510731265882, 3438.914027149291, 3451.775634583744, 3463.2034632034774, 3475.7045651119433, 3478.513008178857, 527.4777969809937, 624.4816802054283, 624.8781487609963, 646.3019938466445, 647.1748520636227, 519.867433804385, 544.8556132624858, 597.8774351257981, 598.6408155106901, 605.1588292273743, 8607.096254893146, 8867.911320886838, 9336.579853906454, 9356.204722598655, 9359.578818953163, 516.7648719832467, 540.7647673262144, 580.7647902599454, 612.9387061293924, 627.8085184018827, 4029.49631296088, 4131.814068366931, 4150.771707556053, 4164.354525048622, 4247.723897946686, 78631.0, 88561.55719221363, 98502.0, 99900.00099999053, 100439.0, 59080.40919590835, 78056.82914756284, 78860.6056969723, 78961.60519197368, 79000.0, 68546.0, 72518.27481725221, 74279.0, 74911.50176996429, 75962.62018689871, 8950.418222815757, 9006.324525660733, 9119.133682300171, 9123.863142053007, 9170.0, 49058.77353066059, 54833.0, 55572.16641750296, 55835.72082139563, 55946.160807587105, 68507.62984740378, 72951.27048729657, 76690.6165469169, 78017.60991195234, 79438.0, 11377.2604780689, 11403.0, 11415.600453984403, 11677.240979336317, 12182.939085304517, 10517.9474102629, 12041.879581204075, 12087.51649934028, 12161.87838121643, 12594.622161335175, 9512.858456985206, 9710.417374957526, 11457.885421145682, 11650.009749171415, 11939.343336116597, 11237.770397630347, 11509.366984815915, 11800.822987655363, 11984.221025633306, 12418.130730848754, 11137.888621113685, 11275.154363422613, 11415.258008229439, 11473.82789258145, 12243.265404075784, 9529.106782809093, 9545.284103692113, 9650.613975440903, 9754.365966212174, 10484.895151048391, 9013.954930225307, 9169.495677737788, 10016.148627366756, 10059.195264378686, 10068.194544436281], "unit": "ms", "name": "yui.html", "value": 7077.2747826670075}], "name": "dromaeo_css", "value": 7510.780343440399}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 103.0, 113.0, 125.0, 167.0, 130.0, 122.0, 164.0, 115.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 126.7}, {"lowerIsBetter": true, "replicates": [148.0, 127.0, 163.0, 184.0, 109.0, 161.0, 174.0, 150.0, 166.0, 148.0], "unit": "ms", "name": "audio-beat-detection", "value": 153.0}, {"lowerIsBetter": true, "replicates": [197.0, 195.0, 192.0, 207.0, 223.0, 204.0, 180.0, 272.0, 261.0, 198.0], "unit": "ms", "name": "audio-dft", "value": 212.9}, {"lowerIsBetter": true, "replicates": [67.0, 60.0, 70.0, 112.0, 57.0, 58.0, 59.0, 59.0, 113.0, 59.0], "unit": "ms", "name": "audio-fft", "value": 71.4}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 108.0, 74.0, 76.0, 80.0, 119.0, 77.0, 78.0, 93.0], "unit": "ms", "name": "audio-oscillator", "value": 85.8}, {"lowerIsBetter": true, "replicates": [79.0, 126.0, 133.0, 115.0, 87.0, 78.0, 132.0, 90.0, 97.0, 89.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 102.6}, {"lowerIsBetter": true, "replicates": [151.0, 132.0, 94.0, 134.0, 107.0, 96.0, 96.0, 104.0, 95.0, 115.0], "unit": "ms", "name": "imaging-darkroom", "value": 112.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 92.0, 91.0, 91.0, 93.0, 95.0, 138.0, 145.0, 115.0], "unit": "ms", "name": "imaging-desaturate", "value": 104.6}, {"lowerIsBetter": true, "replicates": [59.0, 61.0, 59.0, 59.0, 59.0, 61.0, 52.0, 59.0, 61.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 82.0, 67.0, 66.0, 65.0, 68.0, 68.0, 85.0, 103.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 73.6}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 85.0, 84.0, 86.0, 84.0, 84.0, 85.0, 88.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [143.0, 122.0, 121.0, 134.0, 131.0, 135.0, 130.0, 127.0, 134.0, 113.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.0}, {"lowerIsBetter": true, "replicates": [143.0, 141.0, 137.0, 139.0, 139.0, 139.0, 140.0, 139.0, 135.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1522.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [178.9549033643522], "unit": "score", "name": "Richards", "value": 197.26757599999996}, {"lowerIsBetter": false, "replicates": [165.72754391779912], "unit": "score", "name": "DeltaBlue", "value": 398.9560119999999}, {"lowerIsBetter": false, "replicates": [283.4467120181406], "unit": "score", "name": "Encrypt", "value": 939.0865680000002}, {"lowerIsBetter": false, "replicates": [4794.258373205742], "unit": "score", "name": "Decrypt", "value": 55.52078742514974}, {"lowerIsBetter": false, "replicates": [948.7666034155598], "unit": "score", "name": "RayTrace", "value": 779.9484060000001}, {"lowerIsBetter": false, "replicates": [720.9805335255949], "unit": "score", "name": "Earley", "value": 924.3841810000001}, {"lowerIsBetter": false, "replicates": [16129.032258064517], "unit": "score", "name": "Boyer", "value": 41.32070599999999}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [769.2307692307693], "unit": "score", "name": "Splay", "value": 105.93829999999996}, {"lowerIsBetter": false, "replicates": [4921.568627450981], "unit": "score", "name": "NavierStokes", "value": 301.52988047808736}], "name": "v8_7", "value": 20603.553731703836}]} 10:21:15 INFO - RETURN: dromaeo_css: 7510.78 10:21:15 INFO - RETURN: kraken: 1522.60 10:21:15 INFO - RETURN: v8_7: 20603.55 10:21:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "20603.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1522.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7510.78"}}} 10:21:15 INFO - Return code: 0 10:21:15 INFO - # TBPL SUCCESS # 10:21:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:21:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:21:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:21:15 INFO - 2015-11-24 10:21:15.843 screenresolution[2936:30172] starting screenresolution argv=screenresolution get 10:21:15 INFO - 2015-11-24 10:21:15.846 screenresolution[2936:30172] Display 0: 1600x1200x32@60 10:21:15 INFO - 2015-11-24 10:21:15.852 screenresolution[2937:30175] starting screenresolution argv=screenresolution list 10:21:15 INFO - Available Modes on Display 0 10:21:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:21:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:21:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:21:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:21:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:21:16 INFO - Intel Iris: 10:21:16 INFO - Chipset Model: Intel Iris 10:21:16 INFO - Type: GPU 10:21:16 INFO - Bus: Built-In 10:21:16 INFO - VRAM (Dynamic, Max): 1536 MB 10:21:16 INFO - Vendor: Intel (0x8086) 10:21:16 INFO - Device ID: 0x0a2e 10:21:16 INFO - Revision ID: 0x0009 10:21:16 INFO - Displays: 10:21:16 INFO - Display: 10:21:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:21:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:21:16 INFO - Display Serial Number: 1600x1200 60 10:21:16 INFO - Main Display: Yes 10:21:16 INFO - Mirror: Off 10:21:16 INFO - Online: Yes 10:21:16 INFO - Rotation: Supported 10:21:16 INFO - Return code: 0 10:21:16 INFO - Running post-action listener: _resource_record_post_action 10:21:16 INFO - Running post-run listener: _resource_record_post_run 10:21:17 INFO - Total resource usage - Wall time: 1237s; CPU: 53.0%; Read bytes: 16384; Write bytes: 692321280; Read time: 0; Write time: 2068 10:21:17 INFO - install - Wall time: 31s; CPU: 55.0%; Read bytes: 333804032; Write bytes: 335492608; Read time: 25869; Write time: 607 10:21:17 INFO - run-tests - Wall time: 1207s; CPU: 53.0%; Read bytes: 16384; Write bytes: 345277952; Read time: 0; Write time: 1428 10:21:17 INFO - Running post-run listener: _upload_blobber_files 10:21:17 INFO - Blob upload gear active. 10:21:17 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:21:17 INFO - Copying logs to upload dir... 10:21:17 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.270826 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-24 10:21:17.209896) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 10:21:17.213057) ========= 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.4M6waryZ8X/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.S6ZFGohRYa/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009526 build_url: 'https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 10:21:17.236685) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:21:17.236987) ========= 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.4M6waryZ8X/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.S6ZFGohRYa/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005296 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 10:21:17.287614) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 10:21:17.287992) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 10:21:17.288393) ========= ========= Total master_lag: 0.21 =========