builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0047 starttime: 1447293610.1 results: success (0) buildid: 20151111155147 builduid: ae39a908d58842238318643c45d2142b revision: dd627c83397a2be0216a881e6a58e5f5f5675cdd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.101382) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.101918) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.102266) ========= 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.EivGNJWvi7/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.EXF814vlsp/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005982 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.167113) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.167488) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.210822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.211273) ========= 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.EivGNJWvi7/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.EXF814vlsp/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.013372 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.261102) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.261437) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.261803) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.262079) ========= 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.EivGNJWvi7/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.EXF814vlsp/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-11 18:00:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.73M=0.001s 2015-11-11 18:00:10 (8.73 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.208877 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.486574) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.486949) ========= 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.EivGNJWvi7/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.EXF814vlsp/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.122048 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:10.624009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-11 18:00:10.624405) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd627c83397a2be0216a881e6a58e5f5f5675cdd --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 dd627c83397a2be0216a881e6a58e5f5f5675cdd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EivGNJWvi7/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.EXF814vlsp/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-11 18:00:10,708 truncating revision to first 12 chars 2015-11-11 18:00:10,708 Setting DEBUG logging. 2015-11-11 18:00:10,708 attempt 1/10 2015-11-11 18:00:10,708 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd627c83397a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 18:00:11,430 unpacking tar archive at: fx-team-dd627c83397a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.979547 ========= master_lag: 1.94 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-11 18:00:13.540828) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 6 secs) (at 2015-11-11 18:00:13.541239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 6 secs) (at 2015-11-11 18:00:20.122055) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:20.122451) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 18:00:20.122989) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2015-11-11 18:00:20.123288) ========= /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.EivGNJWvi7/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.EXF814vlsp/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 18:00:20 INFO - MultiFileLogger online at 20151111 18:00:20 in /builds/slave/test 18:00:20 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 18:00:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:00:20 INFO - {'append_to_log': False, 18:00:20 INFO - 'base_work_dir': '/builds/slave/test', 18:00:20 INFO - 'blob_upload_branch': 'Fx-Team', 18:00:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:00:20 INFO - 'branch': 'Fx-Team', 18:00:20 INFO - 'buildbot_json_path': 'buildprops.json', 18:00:20 INFO - 'config_files': ('talos/mac_config.py',), 18:00:20 INFO - 'default_actions': ('clobber', 18:00:20 INFO - 'read-buildbot-config', 18:00:20 INFO - 'download-and-extract', 18:00:20 INFO - 'populate-webroot', 18:00:20 INFO - 'create-virtualenv', 18:00:20 INFO - 'install', 18:00:20 INFO - 'run-tests'), 18:00:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:00:20 INFO - 'download_minidump_stackwalk': True, 18:00:20 INFO - 'download_symbols': 'ondemand', 18:00:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:00:20 INFO - 'tooltool.py': '/tools/tooltool.py', 18:00:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:00:20 INFO - '/tools/misc-python/virtualenv.py')}, 18:00:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:00:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:00:20 INFO - 'installer_path': 'installer.exe', 18:00:20 INFO - 'log_level': 'info', 18:00:20 INFO - 'log_name': 'talos', 18:00:20 INFO - 'log_to_console': True, 18:00:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:00:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:00:20 INFO - 'opt_config_files': (), 18:00:20 INFO - 'pip_index': False, 18:00:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:00:20 INFO - 'cmd': ('bash', 18:00:20 INFO - '-c', 18:00:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:00:20 INFO - 'enabled': True, 18:00:20 INFO - 'halt_on_failure': False, 18:00:20 INFO - 'name': 'check_screen_resolution'},), 18:00:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:00:20 INFO - 'cmd': ('bash', 18:00:20 INFO - '-c', 18:00:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:00:20 INFO - 'enabled': True, 18:00:20 INFO - 'halt_on_failure': False, 18:00:20 INFO - 'name': 'check_screen_resolution'},), 18:00:20 INFO - 'run_cmd_checks_enabled': True, 18:00:20 INFO - 'sps_profile': False, 18:00:20 INFO - 'sps_profile_interval': 0, 18:00:20 INFO - 'suite': 'dromaeojs-e10s', 18:00:20 INFO - 'system_bits': '64', 18:00:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:00:20 INFO - 'title': 't-yosemite-r5-0047', 18:00:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:00:20 INFO - 'use_talos_json': True, 18:00:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:00:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:00:20 INFO - 'work_dir': 'build'} 18:00:20 INFO - ##### 18:00:20 INFO - ##### Running clobber step. 18:00:20 INFO - ##### 18:00:20 INFO - Running pre-action listener: _resource_record_pre_action 18:00:20 INFO - Running main action method: clobber 18:00:20 INFO - rmtree: /builds/slave/test/build 18:00:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:00:23 INFO - Running post-action listener: _resource_record_post_action 18:00:23 INFO - ##### 18:00:23 INFO - ##### Running read-buildbot-config step. 18:00:23 INFO - ##### 18:00:23 INFO - Running pre-action listener: _resource_record_pre_action 18:00:23 INFO - Running main action method: read_buildbot_config 18:00:23 INFO - Using buildbot properties: 18:00:23 INFO - { 18:00:23 INFO - "properties": { 18:00:23 INFO - "buildnumber": 26, 18:00:23 INFO - "product": "firefox", 18:00:23 INFO - "script_repo_revision": "production", 18:00:23 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 18:00:23 INFO - "repository": "", 18:00:23 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 18:00:23 INFO - "buildid": "20151111155147", 18:00:23 INFO - "slavename": "t-yosemite-r5-0047", 18:00:23 INFO - "pgo_build": "False", 18:00:23 INFO - "basedir": "/builds/slave/test", 18:00:23 INFO - "project": "", 18:00:23 INFO - "platform": "yosemite", 18:00:23 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:00:23 INFO - "slavebuilddir": "test", 18:00:23 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:00:23 INFO - "branch": "fx-team", 18:00:23 INFO - "repo_path": "integration/fx-team", 18:00:23 INFO - "stage_platform": "macosx64", 18:00:23 INFO - "builduid": "ae39a908d58842238318643c45d2142b", 18:00:23 INFO - "revision": "dd627c83397a2be0216a881e6a58e5f5f5675cdd" 18:00:23 INFO - }, 18:00:23 INFO - "sourcestamp": { 18:00:23 INFO - "repository": "", 18:00:23 INFO - "hasPatch": false, 18:00:23 INFO - "project": "", 18:00:23 INFO - "branch": "fx-team-macosx64-talos", 18:00:23 INFO - "changes": [ 18:00:23 INFO - { 18:00:23 INFO - "category": null, 18:00:23 INFO - "files": [ 18:00:23 INFO - { 18:00:23 INFO - "url": null, 18:00:23 INFO - "name": "https://queue.taskcluster.net/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:00:23 INFO - } 18:00:23 INFO - ], 18:00:23 INFO - "repository": "", 18:00:23 INFO - "rev": "dd627c83397a2be0216a881e6a58e5f5f5675cdd", 18:00:23 INFO - "who": "ejpbruel@mozilla.com", 18:00:23 INFO - "when": 1447292257, 18:00:23 INFO - "number": 6651401, 18:00:23 INFO - "comments": "Bug 1207702 - Fix a bug in test_promises_object_timetosettle-02.js;r=fitzgen", 18:00:23 INFO - "project": "", 18:00:23 INFO - "at": "Wed 11 Nov 2015 17:37:37", 18:00:23 INFO - "branch": "fx-team-macosx64-talos", 18:00:23 INFO - "revlink": "", 18:00:23 INFO - "properties": [ 18:00:23 INFO - [ 18:00:23 INFO - "buildid", 18:00:23 INFO - "20151111155147", 18:00:23 INFO - "Change" 18:00:23 INFO - ], 18:00:23 INFO - [ 18:00:23 INFO - "builduid", 18:00:23 INFO - "ae39a908d58842238318643c45d2142b", 18:00:23 INFO - "Change" 18:00:23 INFO - ], 18:00:23 INFO - [ 18:00:23 INFO - "pgo_build", 18:00:23 INFO - "False", 18:00:23 INFO - "Change" 18:00:23 INFO - ] 18:00:23 INFO - ], 18:00:23 INFO - "revision": "dd627c83397a2be0216a881e6a58e5f5f5675cdd" 18:00:23 INFO - } 18:00:23 INFO - ], 18:00:23 INFO - "revision": "dd627c83397a2be0216a881e6a58e5f5f5675cdd" 18:00:23 INFO - } 18:00:23 INFO - } 18:00:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 18:00:23 INFO - Running post-action listener: _resource_record_post_action 18:00:23 INFO - ##### 18:00:23 INFO - ##### Running download-and-extract step. 18:00:23 INFO - ##### 18:00:23 INFO - Running pre-action listener: _resource_record_pre_action 18:00:23 INFO - Running main action method: download_and_extract 18:00:23 INFO - mkdir: /builds/slave/test/build/tests 18:00:23 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')]} 18:00:23 INFO - https://queue.taskcluster.net/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:00:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/test_packages.json 18:00:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/test_packages.json 18:00:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:00:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:00:24 INFO - Downloaded 1149 bytes. 18:00:24 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:00:24 INFO - Using the following test package requirements: 18:00:24 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:00:24 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:00:24 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 18:00:24 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:00:24 INFO - u'jsshell-mac.zip'], 18:00:24 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:00:24 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 18:00:24 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:00:24 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:00:24 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 18:00:24 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:00:24 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 18:00:24 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:00:24 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 18:00:24 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:00:24 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:00:24 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 18:00:24 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18: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')]} 18:00:24 INFO - https://queue.taskcluster.net/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/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 18:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/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 18:00:25 INFO - Downloaded 17454001 bytes. 18:00:25 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 18:00:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:00:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:00:31 INFO - Return code: 0 18:00:31 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 18:00:31 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')]} 18:00:31 INFO - https://queue.taskcluster.net/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:00:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:00:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:00:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/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 18:00:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/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 18:00:32 INFO - Downloaded 17454001 bytes. 18:00:32 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 18:00:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:00:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:00:38 INFO - Return code: 0 18: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')]} 18:00:38 INFO - https://queue.taskcluster.net/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/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 18:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/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 18:00:39 INFO - Downloaded 11131693 bytes. 18:00:39 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 18:00:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:00:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:00:40 INFO - Return code: 0 18:00:40 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')]} 18:00:40 INFO - https://queue.taskcluster.net/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:00:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:00:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:00:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 18:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MiVpYtrrR7mkE_N0HJQceQ/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 18:00:45 INFO - Downloaded 108707024 bytes. 18:00:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:00:45 INFO - mkdir: /builds/slave/test/properties 18:00:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:00:45 INFO - Writing to file /builds/slave/test/properties/build_url 18:00:45 INFO - Contents: 18:00:45 INFO - build_url:https://queue.taskcluster.net/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:00:45 INFO - Running post-action listener: _resource_record_post_action 18:00:45 INFO - Running post-action listener: set_extra_try_arguments 18:00:45 INFO - ##### 18:00:45 INFO - ##### Running populate-webroot step. 18:00:45 INFO - ##### 18:00:45 INFO - Running pre-action listener: _resource_record_pre_action 18:00:45 INFO - Running main action method: populate_webroot 18:00:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:00:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:00:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:00:45 INFO - '../fennec_ids.txt'], 18:00:45 INFO - 'tests': ['tcheck2']}, 18:00:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:00:45 INFO - '--tppagecycles', 18:00:45 INFO - '7'], 18:00:45 INFO - 'tests': ['tsvgm']}}, 18:00:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:00:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:00:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:00:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:00:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:00:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:00:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:45 INFO - 'talos_options': ['--e10s'], 18:00:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:00:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:45 INFO - 'tests': ['damp', 'tps']}, 18:00:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:45 INFO - 'talos_options': ['--e10s'], 18:00:45 INFO - 'tests': ['damp', 'tps']}, 18:00:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:00:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:00:45 INFO - 'other': {'tests': ['a11yr', 18:00:45 INFO - 'ts_paint', 18:00:45 INFO - 'tpaint', 18:00:45 INFO - 'sessionrestore', 18:00:45 INFO - 'sessionrestore_no_auto_restore']}, 18:00:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:00:45 INFO - 'tests': ['a11yr', 18:00:45 INFO - 'ts_paint', 18:00:45 INFO - 'tpaint', 18:00:45 INFO - 'sessionrestore', 18:00:45 INFO - 'sessionrestore_no_auto_restore']}, 18:00:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:00:45 INFO - 'tests': ['a11yr', 18:00:45 INFO - 'ts_paint', 18:00:45 INFO - 'tpaint', 18:00:45 INFO - 'sessionrestore', 18:00:45 INFO - 'sessionrestore_no_auto_restore']}, 18:00:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:00:45 INFO - 'tests': ['a11yr', 18:00:45 INFO - 'ts_paint', 18:00:45 INFO - 'tpaint', 18:00:45 INFO - 'sessionrestore', 18:00:45 INFO - 'sessionrestore_no_auto_restore']}, 18:00:45 INFO - 'other_l64': {'tests': ['a11yr', 18:00:45 INFO - 'ts_paint', 18:00:45 INFO - 'tpaint', 18:00:45 INFO - 'sessionrestore', 18:00:45 INFO - 'sessionrestore_no_auto_restore']}, 18:00:45 INFO - 'other_nol64': {'tests': ['a11yr', 18:00:45 INFO - 'ts_paint', 18:00:45 INFO - 'tpaint', 18:00:45 INFO - 'sessionrestore', 18:00:45 INFO - 'sessionrestore_no_auto_restore']}, 18:00:45 INFO - 'svgr': {'tests': ['tsvgx', 18:00:45 INFO - 'tsvgr_opacity', 18:00:45 INFO - 'tart', 18:00:45 INFO - 'tscrollx', 18:00:45 INFO - 'cart']}, 18:00:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:00:45 INFO - 'tests': ['tsvgx', 18:00:45 INFO - 'tsvgr_opacity', 18:00:45 INFO - 'tart', 18:00:45 INFO - 'tscrollx', 18:00:45 INFO - 'cart']}, 18:00:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:45 INFO - 'tests': ['tp5o']}, 18:00:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:45 INFO - 'talos_options': ['--e10s'], 18:00:45 INFO - 'tests': ['tp5o']}, 18:00:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:45 INFO - 'talos_options': ['--xperf_path', 18:00:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:45 INFO - 'tests': ['tp5n']}, 18:00:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:00:45 INFO - 'talos_options': ['--e10s', 18:00:45 INFO - '--xperf_path', 18:00:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:00:45 INFO - 'tests': ['tp5n']}}, 18:00:45 INFO - 'talos.zip': {'path': '', 18:00:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:00:45 INFO - Running post-action listener: _resource_record_post_action 18:00:45 INFO - ##### 18:00:45 INFO - ##### Running create-virtualenv step. 18:00:45 INFO - ##### 18:00:45 INFO - Running pre-action listener: _resource_record_pre_action 18:00:45 INFO - Running main action method: create_virtualenv 18:00:45 INFO - Creating virtualenv /builds/slave/test/build/venv 18:00:45 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 18:00:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:00:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:00:45 INFO - Using real prefix '/tools/python27' 18:00:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:00:46 INFO - Installing distribute.............................................................................................................................................................................................done. 18:00:49 INFO - Installing pip.................done. 18:00:49 INFO - Return code: 0 18:00:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:49 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 0x108948490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108925228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c8ce8390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886b9f0>, '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 0x1085cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/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.EXF814vlsp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:49 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 18:00:49 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 18:00:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/Render', 18:00:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:49 INFO - 'HOME': '/Users/cltbld', 18:00:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:49 INFO - 'LOGNAME': 'cltbld', 18:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:49 INFO - 'MOZ_NO_REMOTE': '1', 18:00:49 INFO - 'NO_EM_RESTART': '1', 18:00:49 INFO - 'PAGER': '/bin/cat', 18:00:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:49 INFO - 'PWD': '/builds/slave/test', 18:00:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:49 INFO - 'SHELL': '/bin/bash', 18:00:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EXF814vlsp/Listeners', 18:00:49 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 18:00:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:49 INFO - 'USER': 'cltbld', 18:00:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:49 INFO - 'XPC_FLAGS': '0x0', 18:00:49 INFO - 'XPC_SERVICE_NAME': '0', 18:00:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:50 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 18:00:50 INFO - Cleaning up... 18:00:50 INFO - Return code: 0 18:00:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:00:50 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')]} 18:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:50 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')]} 18:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:50 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 0x108948490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108925228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c8ce8390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886b9f0>, '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 0x1085cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/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.EXF814vlsp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:50 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 18:00:50 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 18:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/Render', 18:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:50 INFO - 'HOME': '/Users/cltbld', 18:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:50 INFO - 'LOGNAME': 'cltbld', 18:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:50 INFO - 'MOZ_NO_REMOTE': '1', 18:00:50 INFO - 'NO_EM_RESTART': '1', 18:00:50 INFO - 'PAGER': '/bin/cat', 18:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:50 INFO - 'PWD': '/builds/slave/test', 18:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:50 INFO - 'SHELL': '/bin/bash', 18:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EXF814vlsp/Listeners', 18:00:50 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 18:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:50 INFO - 'USER': 'cltbld', 18:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:50 INFO - 'XPC_FLAGS': '0x0', 18:00:50 INFO - 'XPC_SERVICE_NAME': '0', 18:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:50 INFO - Downloading/unpacking psutil>=0.7.1 18:00:50 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 18:00:50 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 18:00:50 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 18:00:50 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 18:00:50 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 18:00:50 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 18:00:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:00:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:53 INFO - Installing collected packages: psutil 18:00:53 INFO - Running setup.py install for psutil 18:00:53 INFO - building 'psutil._psutil_osx' extension 18:00:53 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 18:00:55 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 18:00:55 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 18:00:55 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 18:00:55 INFO - building 'psutil._psutil_posix' extension 18:00:55 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 18:00:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:00:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:00:55 INFO - ^ 18:00:56 INFO - 1 warning generated. 18:00:56 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 18:00:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:00:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:00:56 INFO - Successfully installed psutil 18:00:56 INFO - Cleaning up... 18:00:56 INFO - Return code: 0 18:00:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:56 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 0x108948490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108925228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c8ce8390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886b9f0>, '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 0x1085cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/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.EXF814vlsp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:56 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 18:00:56 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 18:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/Render', 18:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:56 INFO - 'HOME': '/Users/cltbld', 18:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:56 INFO - 'LOGNAME': 'cltbld', 18:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:56 INFO - 'MOZ_NO_REMOTE': '1', 18:00:56 INFO - 'NO_EM_RESTART': '1', 18:00:56 INFO - 'PAGER': '/bin/cat', 18:00:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:56 INFO - 'PWD': '/builds/slave/test', 18:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:56 INFO - 'SHELL': '/bin/bash', 18:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EXF814vlsp/Listeners', 18:00:56 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 18:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:56 INFO - 'USER': 'cltbld', 18:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:56 INFO - 'XPC_FLAGS': '0x0', 18:00:56 INFO - 'XPC_SERVICE_NAME': '0', 18:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:00:56 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 18:00:56 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 18:00:56 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 18:00:56 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 18:00:56 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 18:00:56 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 18:00:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:00:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:00:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:00:58 INFO - Installing collected packages: mozsystemmonitor 18:00:58 INFO - Running setup.py install for mozsystemmonitor 18:00:59 INFO - Successfully installed mozsystemmonitor 18:00:59 INFO - Cleaning up... 18:00:59 INFO - Return code: 0 18:00:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:00: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')]} 18:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00: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')]} 18:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:00:59 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 0x108948490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108925228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c8ce8390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886b9f0>, '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 0x1085cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/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.EXF814vlsp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:00:59 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 18:00:59 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 18:00:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/Render', 18:00:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:00:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:00:59 INFO - 'HOME': '/Users/cltbld', 18:00:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:00:59 INFO - 'LOGNAME': 'cltbld', 18:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:00:59 INFO - 'MOZ_NO_REMOTE': '1', 18:00:59 INFO - 'NO_EM_RESTART': '1', 18:00:59 INFO - 'PAGER': '/bin/cat', 18:00:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:00:59 INFO - 'PWD': '/builds/slave/test', 18:00:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:00:59 INFO - 'SHELL': '/bin/bash', 18:00:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EXF814vlsp/Listeners', 18:00:59 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 18:00:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:00:59 INFO - 'USER': 'cltbld', 18:00:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:00:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:00:59 INFO - 'XPC_FLAGS': '0x0', 18:00:59 INFO - 'XPC_SERVICE_NAME': '0', 18:00:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:00:59 INFO - Downloading/unpacking blobuploader==1.2.4 18:00:59 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 18:00:59 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 18:00:59 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 18:00:59 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 18:00:59 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 18:00:59 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 18:01:01 INFO - Downloading blobuploader-1.2.4.tar.gz 18:01:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:01:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:01:01 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 18:01:01 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 18:01:01 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 18:01:01 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 18:01:01 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 18:01:01 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 18:01:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:01:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:01:02 INFO - Downloading docopt-0.6.1.tar.gz 18:01:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:01:03 INFO - Installing collected packages: blobuploader, requests, docopt 18:01:03 INFO - Running setup.py install for blobuploader 18:01:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:01:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:01:03 INFO - Running setup.py install for requests 18:01:03 INFO - Running setup.py install for docopt 18:01:03 INFO - Successfully installed blobuploader requests docopt 18:01:03 INFO - Cleaning up... 18:01:03 INFO - Return code: 0 18:01:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:03 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')]} 18:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:03 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')]} 18:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:03 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 0x108948490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108925228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c8ce8390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886b9f0>, '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 0x1085cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/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.EXF814vlsp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:01:03 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 18:01:03 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 18:01:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/Render', 18:01:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:03 INFO - 'HOME': '/Users/cltbld', 18:01:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:03 INFO - 'LOGNAME': 'cltbld', 18:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:03 INFO - 'MOZ_NO_REMOTE': '1', 18:01:03 INFO - 'NO_EM_RESTART': '1', 18:01:03 INFO - 'PAGER': '/bin/cat', 18:01:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:03 INFO - 'PWD': '/builds/slave/test', 18:01:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:03 INFO - 'SHELL': '/bin/bash', 18:01:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EXF814vlsp/Listeners', 18:01:03 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 18:01:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:03 INFO - 'USER': 'cltbld', 18:01:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:03 INFO - 'XPC_FLAGS': '0x0', 18:01:03 INFO - 'XPC_SERVICE_NAME': '0', 18:01:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:01:04 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-mHVS14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:01:04 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-SSpzlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:01:04 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-4s0s8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:01:04 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-RGz20Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:01:04 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-gaShQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:01:04 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-ot8Fv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:01:04 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-YkXkL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:01:05 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-uHySGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:01:05 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-DEoeV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:01:05 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-uXuReW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:01:05 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-kq7TNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:01:05 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-N2FJaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:01:05 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-8xe7wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:01:05 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-ILLTrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:01:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:05 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-DA5CmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:01:06 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-XGBBLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:01:06 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-RCKaMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:01:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:01:06 INFO - Running setup.py install for manifestparser 18:01:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:01:06 INFO - Running setup.py install for mozcrash 18:01:06 INFO - Running setup.py install for mozdebug 18:01:06 INFO - Running setup.py install for mozdevice 18:01:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:01:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:01:06 INFO - Running setup.py install for mozfile 18:01:07 INFO - Running setup.py install for mozhttpd 18:01:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:01:07 INFO - Running setup.py install for mozinfo 18:01:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:01:07 INFO - Running setup.py install for mozInstall 18:01:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:01:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:01:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:01:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:01:07 INFO - Running setup.py install for mozleak 18:01:07 INFO - Running setup.py install for mozlog 18:01:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:01:07 INFO - Running setup.py install for moznetwork 18:01:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:01:08 INFO - Running setup.py install for mozprocess 18:01:08 INFO - Running setup.py install for mozprofile 18:01:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:01:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:01:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:01:08 INFO - Running setup.py install for mozrunner 18:01:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:01:08 INFO - Running setup.py install for mozscreenshot 18:01:08 INFO - Running setup.py install for moztest 18:01:08 INFO - Running setup.py install for mozversion 18:01:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:01:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:01:09 INFO - Cleaning up... 18:01:09 INFO - Return code: 0 18:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18: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')]} 18:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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')]} 18:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x108948490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108925228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c8ce8390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886b9f0>, '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 0x1085cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/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.EXF814vlsp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:01:09 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 18:01:09 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 18:01:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/Render', 18:01:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:09 INFO - 'HOME': '/Users/cltbld', 18:01:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:09 INFO - 'LOGNAME': 'cltbld', 18:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:09 INFO - 'MOZ_NO_REMOTE': '1', 18:01:09 INFO - 'NO_EM_RESTART': '1', 18:01:09 INFO - 'PAGER': '/bin/cat', 18:01:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:09 INFO - 'PWD': '/builds/slave/test', 18:01:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:09 INFO - 'SHELL': '/bin/bash', 18:01:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EXF814vlsp/Listeners', 18:01:09 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 18:01:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:09 INFO - 'USER': 'cltbld', 18:01:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:09 INFO - 'XPC_FLAGS': '0x0', 18:01:09 INFO - 'XPC_SERVICE_NAME': '0', 18:01:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:01:09 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-TmwkNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:01:09 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)) 18:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:01:09 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-zHS0Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:01:09 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)) 18:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:01:09 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-qmcvX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:01:09 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)) 18:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:01:09 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-z4i1LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:01:09 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)) 18:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:01:09 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-HSxqDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:01:10 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)) 18:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:01:10 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-N0nS6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:01:10 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)) 18:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:01:10 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-nrQwOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:01:10 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)) 18:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:01:10 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-oXF5WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:01:10 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)) 18:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:01:10 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-qX3tH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:01:10 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)) 18:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:01:10 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-3SUWLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:01:10 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-Az500A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:01:10 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)) 18:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:01:10 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-gXbKX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:01:10 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)) 18:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:01:10 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-Wcz0z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:01:11 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)) 18:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:01:11 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-p1VOqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:01:11 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)) 18:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:11 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-ntnu2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:01:11 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)) 18:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:01:11 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-5_hQDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:01:11 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)) 18:01:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:01:11 INFO - Running setup.py (path:/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/pip-qDLbKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:01:11 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)) 18:01:11 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)) 18:01:11 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)) 18:01:11 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)) 18:01:11 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)) 18:01:11 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)) 18:01:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:01:11 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 18:01:11 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 18:01:11 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 18:01:11 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 18:01:11 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 18:01:11 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 18:01:13 INFO - Downloading blessings-1.5.1.tar.gz 18:01:13 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 18:01:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:01:14 INFO - Installing collected packages: blessings 18:01:14 INFO - Running setup.py install for blessings 18:01:14 INFO - Successfully installed blessings 18:01:14 INFO - Cleaning up... 18:01:14 INFO - Return code: 0 18:01:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:01:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:01:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:01:14 INFO - Reading from file tmpfile_stdout 18:01:14 INFO - Current package versions: 18:01:14 INFO - blessings == 1.5.1 18:01:14 INFO - blobuploader == 1.2.4 18:01:14 INFO - docopt == 0.6.1 18:01:14 INFO - manifestparser == 1.1 18:01:14 INFO - mozInstall == 1.12 18:01:14 INFO - mozcrash == 0.16 18:01:14 INFO - mozdebug == 0.1 18:01:14 INFO - mozdevice == 0.47 18:01:14 INFO - mozfile == 1.2 18:01:14 INFO - mozhttpd == 0.7 18:01:14 INFO - mozinfo == 0.9 18:01:14 INFO - mozleak == 0.1 18:01:14 INFO - mozlog == 3.0 18:01:14 INFO - moznetwork == 0.27 18:01:14 INFO - mozprocess == 0.22 18:01:14 INFO - mozprofile == 0.27 18:01:14 INFO - mozrunner == 6.11 18:01:14 INFO - mozscreenshot == 0.1 18:01:14 INFO - mozsystemmonitor == 0.0 18:01:14 INFO - moztest == 0.7 18:01:14 INFO - mozversion == 1.4 18:01:14 INFO - psutil == 3.1.1 18:01:14 INFO - requests == 1.2.3 18:01:14 INFO - wsgiref == 0.1.2 18:01:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:01:14 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')]} 18:01:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:01:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:14 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')]} 18:01:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:01:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:01:14 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 0x108948490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108925228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1c8ce8390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886b9f0>, '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 0x1085cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885f8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/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.EXF814vlsp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 18:01:14 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 18:01:14 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 18:01:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/Render', 18:01:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:14 INFO - 'HOME': '/Users/cltbld', 18:01:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:14 INFO - 'LOGNAME': 'cltbld', 18:01:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:14 INFO - 'MOZ_NO_REMOTE': '1', 18:01:14 INFO - 'NO_EM_RESTART': '1', 18:01:14 INFO - 'PAGER': '/bin/cat', 18:01:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:14 INFO - 'PWD': '/builds/slave/test', 18:01:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:14 INFO - 'SHELL': '/bin/bash', 18:01:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EXF814vlsp/Listeners', 18:01:14 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 18:01:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:14 INFO - 'USER': 'cltbld', 18:01:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:14 INFO - 'XPC_FLAGS': '0x0', 18:01:14 INFO - 'XPC_SERVICE_NAME': '0', 18:01:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:01:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:01:14 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)) 18:01:14 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)) 18:01:14 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)) 18:01:14 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)) 18:01:14 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)) 18:01:14 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)) 18:01:14 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)) 18:01:14 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)) 18:01:14 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)) 18:01:14 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)) 18:01:14 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)) 18:01:14 INFO - Cleaning up... 18:01:15 INFO - Return code: 0 18:01:15 INFO - Running post-action listener: _resource_record_post_action 18:01:15 INFO - Running post-action listener: _start_resource_monitoring 18:01:15 INFO - Starting resource monitoring. 18:01:15 INFO - ##### 18:01:15 INFO - ##### Running install step. 18:01:15 INFO - ##### 18:01:15 INFO - Running pre-action listener: _resource_record_pre_action 18:01:15 INFO - Running main action method: install 18:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:01:15 INFO - Reading from file tmpfile_stdout 18:01:15 INFO - Detecting whether we're running mozinstall >=1.0... 18:01:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:01:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:01:15 INFO - Reading from file tmpfile_stdout 18:01:15 INFO - Output received: 18:01:15 INFO - Usage: mozinstall [options] installer 18:01:15 INFO - Options: 18:01:15 INFO - -h, --help show this help message and exit 18:01:15 INFO - -d DEST, --destination=DEST 18:01:15 INFO - Directory to install application into. [default: 18:01:15 INFO - "/builds/slave/test"] 18:01:15 INFO - --app=APP Application being installed. [default: firefox] 18:01:15 INFO - mkdir: /builds/slave/test/build/application 18:01:15 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'] 18:01:15 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 18:01:52 INFO - Reading from file tmpfile_stdout 18:01:52 INFO - Output received: 18:01:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:01:52 INFO - Running post-action listener: _resource_record_post_action 18:01:52 INFO - ##### 18:01:52 INFO - ##### Running run-tests step. 18:01:52 INFO - ##### 18:01:52 INFO - Running pre-action listener: _resource_record_pre_action 18:01:52 INFO - Running main action method: run_tests 18:01:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:01:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:01:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:01:52 INFO - 2015-11-11 18:01:52.417 screenresolution[1622:7568] starting screenresolution argv=screenresolution get 18:01:52 INFO - 2015-11-11 18:01:52.420 screenresolution[1622:7568] Display 0: 1600x1200x32@60 18:01:52 INFO - 2015-11-11 18:01:52.427 screenresolution[1623:7570] starting screenresolution argv=screenresolution list 18:01:52 INFO - Available Modes on Display 0 18:01:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:01:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:01:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:01:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:01:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:01:52 INFO - Intel HD Graphics 3000: 18:01:52 INFO - Chipset Model: Intel HD Graphics 3000 18:01:52 INFO - Type: GPU 18:01:52 INFO - Bus: Built-In 18:01:52 INFO - VRAM (Total): 512 MB 18:01:52 INFO - VRAM (Dynamic, Max): 10 18:01:52 INFO - Vendor: Intel (0x8086) 18:01:52 INFO - Device ID: 0x0116 18:01:52 INFO - Revision ID: 0x0009 18:01:52 INFO - Displays: 18:01:52 INFO - Display: 18:01:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:01:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:01:52 INFO - Display Serial Number: 1600x1200 60 18:01:52 INFO - Main Display: Yes 18:01:52 INFO - Mirror: Off 18:01:52 INFO - Online: Yes 18:01:52 INFO - Rotation: Supported 18:01:52 INFO - Return code: 0 18:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:01:52 INFO - Python 2.7.3 18:01:52 INFO - Return code: 0 18:01:52 INFO - grabbing minidump binary from tooltool 18:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:01:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10886b9f0>, '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 0x1085cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10885f8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:01:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:01:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 18:01:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:01:52 INFO - Return code: 0 18:01:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:01:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:01:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:01:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:01:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:01:52 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/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0047', '--webServer', 'localhost'] in /builds/slave/test/build 18:01:52 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/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0047 --webServer localhost 18:01:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EivGNJWvi7/Render', 18:01:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:01:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:01:52 INFO - 'HOME': '/Users/cltbld', 18:01:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:01:52 INFO - 'LOGNAME': 'cltbld', 18:01:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:01:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:01:52 INFO - 'MOZ_NO_REMOTE': '1', 18:01:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:01:52 INFO - 'NO_EM_RESTART': '1', 18:01:52 INFO - 'PAGER': '/bin/cat', 18:01:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:01:52 INFO - 'PWD': '/builds/slave/test', 18:01:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:01:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:01:52 INFO - 'SHELL': '/bin/bash', 18:01:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EXF814vlsp/Listeners', 18:01:52 INFO - 'TMPDIR': '/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/', 18:01:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:01:52 INFO - 'USER': 'cltbld', 18:01:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:01:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:01:52 INFO - 'XPC_FLAGS': '0x0', 18:01:52 INFO - 'XPC_SERVICE_NAME': '0', 18:01:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:01:52 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/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0047', '--webServer', 'localhost'] with output_timeout 3600 18:01:53 INFO - mozversion INFO | application_buildid: 20151111155147 18:01:53 INFO - mozversion INFO | application_changeset: dd627c83397a2be0216a881e6a58e5f5f5675cdd 18:01:53 INFO - mozversion INFO | application_display_name: Nightly 18:01:53 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:01:53 INFO - mozversion INFO | application_name: Firefox 18:01:53 INFO - mozversion INFO | application_remotingname: firefox 18:01:53 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 18:01:53 INFO - mozversion INFO | application_vendor: Mozilla 18:01:53 INFO - mozversion INFO | application_version: 45.0a1 18:01:53 INFO - mozversion INFO | platform_buildid: 20151111155147 18:01:53 INFO - mozversion INFO | platform_changeset: dd627c83397a2be0216a881e6a58e5f5f5675cdd 18:01:53 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 18:01:53 INFO - mozversion INFO | platform_version: 45.0a1 18:01:53 INFO - 2015-11-11 18:01:53,119 DEBUG : using testdate: 1447293713 18:01:53 INFO - 2015-11-11 18:01:53,119 DEBUG : actual date: 1447293713 18:01:53 INFO - 2015-11-11 18:01:53,128 INFO : starting webserver on 'localhost:49275' 18:01:53 INFO - 2015-11-11 18:01:53,129 INFO : Starting test suite t-yosemite-r5-0047.e 18:01:53 INFO - 2015-11-11 18:01:53,129 INFO : Starting test dromaeo_css 18:01:53 INFO - 2015-11-11 18:01:53,129 DEBUG : operating with platform_type : mac_ 18:01:53 INFO - 2015-11-11 18:01:53,130 INFO : Initialising browser for dromaeo_css test... 18:01:53 INFO - 2015-11-11 18:01:53,154 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpbfUdeI/profile http://localhost:49275/getInfo.html 18:01:57 INFO - 2015-11-11 18:01:57,340 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:01:57 INFO - 2015-11-11 18:01:57,341 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:01:57 INFO - 2015-11-11 18:01:57,341 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:01:57 INFO - 2015-11-11 18:01:57,341 DEBUG : BROWSER_OUTPUT: __metrics 18:01:58 INFO - 2015-11-11 18:01:58,005 INFO : Browser initialized. 18:01:58 INFO - 2015-11-11 18:01:58,005 INFO : Running cycle 1/1 for dromaeo_css test... 18:01:58 INFO - 2015-11-11 18:01:58,005 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpbfUdeI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:02:10 INFO - 2015-11-11 18:02:10,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 240291840 18:02:10 INFO - 2015-11-11 18:02:10,196 DEBUG : BROWSER_OUTPUT: 18:03:00 INFO - 2015-11-11 18:03:00,032 DEBUG : BROWSER_OUTPUT: 1447293780028 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] 18:05:10 INFO - 2015-11-11 18:05:10,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 18:05:11 INFO - 2015-11-11 18:05:11,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 265728000 18:05:11 INFO - 2015-11-11 18:05:11,498 DEBUG : BROWSER_OUTPUT: 18:08:13 INFO - 2015-11-11 18:08:13,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 18:08:14 INFO - 2015-11-11 18:08:14,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 272199680 18:08:14 INFO - 2015-11-11 18:08:14,166 DEBUG : BROWSER_OUTPUT: 18:11:15 INFO - 2015-11-11 18:11:15,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 18:11:16 INFO - 2015-11-11 18:11:16,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 274231296 18:11:16 INFO - 2015-11-11 18:11:16,415 DEBUG : BROWSER_OUTPUT: 18:14:18 INFO - 2015-11-11 18:14:18,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 18:14:18 INFO - 2015-11-11 18:14:18,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 278626304 18:14:18 INFO - 2015-11-11 18:14:18,718 DEBUG : BROWSER_OUTPUT: 18:17:21 INFO - 2015-11-11 18:17:21,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 18:17:22 INFO - 2015-11-11 18:17:22,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 283693056 18:17:22 INFO - 2015-11-11 18:17:22,003 DEBUG : BROWSER_OUTPUT: 18:20:24 INFO - 2015-11-11 18:20:24,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 18:20:24 INFO - 2015-11-11 18:20:24,659 DEBUG : BROWSER_OUTPUT: RSS: Main: 288071680 18:20:24 INFO - 2015-11-11 18:20:24,660 DEBUG : BROWSER_OUTPUT: 18:20:24 INFO - 2015-11-11 18:20:24,660 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:20:24 INFO - 2015-11-11 18:20:24,660 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:20:24 INFO - 2015-11-11 18:20:24,660 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:20:24 INFO - 2015-11-11 18:20:24,660 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:20:24 INFO - 2015-11-11 18:20:24,661 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3158.936821263575;3189.234583699911;3209.614846218454;3230.192451887029;3246.4643333849917;5527.143292789619;5546.2512560804325;5571.972140139299;5588.608797384185;5595.468430499106;5314.867128321794;5420.430854760242;5444.3194600674915;5536.612437129403;5551.8889622207535;5173.094708426029;5192.740362981855;5255.316808814868;5265.65773224741;5267.341582302212;749.1300821286743;5223.503767142115;5250.527452529272;5258.342707161605;5336.653117547347;5208.322918020671;5228.738563071831;5237.319148510707;5241.554467870235;5251.291075704769;5249;5261.1319132343115;5272.551833094191;5279.683219006872;5285.048691235576;5012.323336349583;5064.468230835746;5134.0758663440565;5146.356705411824;5182.870428239325;5460.34475862895;5481.725913704299;5484.506394424481;5504.614676972614;5568.610197286192;5750.45370689788;5891.734871930774;5911;5915.497182739472;5925.851853703649;5891.293044834604;5925.170476133345;5940.732667029994;5974.312954010301;5993.0710739835395;5585.972070139624;5586.664800111966;5587.245721827582;5589.301337332833;5601.831945041656;5820.039693450618;5959.731812068468;6095.085737139376;6101.84745381369;6106.72519736604;5692.203091567184;5767.077267637158;5773.364929857712;5786.623869448473;5827.067669172997;5967.283925928917;6004.699765011732;6019.729112189962;6022.217111775529;6030.396960303934;5672.347680016851;5771.163181338682;5774.971125144348;5880.117982302689;5892.175095486636;5887.146363777314;5893.793717219876;5893.941060589425;5906.616069955439;5916.645001299936;4565.018521017997;4569.680122391467;4573.679842411066;4582.1293954148605;4616.907661846744;4025.4163146343617;4079.714419990572;4113.835446582163;4164.604362585549;4173.9582604174175;5583.832485025456;5588.776448941997;5609.074502707089;5628.04323265046;5635.380108188096;6003.249593800775;6012.579119461683;6027.095935609606;6028.125921741411;6046.969765151146;5386.838394848082;5504.532114770209;5583.078791999355;5646.520045796071;5712.885742285131;5291.788328466818;5294.179402192666;5298.28473156119;5303.496167864047;5305.495977882095;5930.229070220844;6184.5980011299125;6220.160278362454;6223.719932602953;6229.937700623026;5857.179994800646;5893.322267939242;5927.881442371215;5929.140274660236;5984.760609575568;6157.722902469489;6161.291451483136;6175.073738939195;6178;6187.876242475035;5731.283589551306;5861.413858614104;5908.793192238251;5917.852053698692;5927.081302398135;5735.254416925773;5855.473007429181;5920.8815823684145;5924.763009479572;5973.790917317873;5844.12338149264;5851.034579294369;5856;5860.238169037998;5867.119932010232;5611.494965453129;5684.77260909559;5723.627964182481;5858.062709966385;5863;5592.664440133605;5710.714464276686;5715.742791574472;5737.08206686928;5743.59794814359;5842.649441033552;5843.795467158629;5854.648721076749;5855.092460668603;5865.853353666193;5443.510084092451;5627.465390787868;5678.432156784289;5739.225204597493;5800.24596802413 18:20:24 INFO - 2015-11-11 18:20:24,661 DEBUG : BROWSER_OUTPUT: |1;ext.html;547.4435419503262;578.6759414727755;578.9855253618659;581.8138195777352;590.4508806809667;38426.61573384266;39635.20729585407;39695.206095878064;39721.2055758885;39762.204755904866;42308.78845605768;42938.14123717524;42959;43009.35485967713;43020.139597208035;9293.256539476859;9431.43411395315;9465.763355916088;9479.289053320994;9493.335466517347;9179.541022948859;9317.487538185396;9318.20795232406;9325.626974920995;9327.300452466092;9384.906150938506;9455.858162127573;9459.952700236523;9464.479453630047;9481.81036379272;9227.123423274777;9299.302552308603;9320.114589114024;9331.673391431268;9335.76660583484;9146.817063658757;9272.026437224062;9283.025282345392;9284.07159284073;9306.115918987685;39275.214495710214;39604.60395396038;39663.60336396628;39733;39736.80131599352;2828.6820776939426;2871.3395918938554;2977.211039074647;3116.407882502317;3255.9580934101095;26866.731332686617;27284.727152728417;27613;27809.721902780915;28319.716802831914;2351.5179388225374;2385.0459816073535;2421.5520128776056;2444.010175878772;2499.7500249975037;256897;257679;257843;259047;259295;56353;56660.43339566634;56704;56713.43286567082;56770.14844777332;56783.43216567864;57811.42188578145;60860;62168.78312168747;62219.37780622136;16244.187790610422;16331.591710207102;16456.67086658284;16458.259378328003;16467.670646587;12443.25340479556;12522.37388130608;12526.498940042296;12527.248365097941;12531.18547294423;18858.811411885705;19154.808451915582;19200.13599388031;19216.327428539935;19233.134508947132;8768.517731524827;8997.505137217386;8999.19007289334;9003.684871029482;9011.459312441275;981.6183248708132;1039.5166247694858;1082.7061661314654;1084.9620263290747;1090.5038207615517;28090.29774255619;28432.28919276993;28742.425151496853;29149.708502915124;29319.706802931698;980.1472718734603;1016.8678071850612;1019.4393083803878;1031.231732359382;1089.9128069754402;13820.723585528232;15223.162726050174;15419;15447.5365739028;15595.220238988006;297652;299925;301064;301798;302644;54220.45779542233;54311;54431;54489.1826622601;54512;1377.1186440677975;1400.7548678981138;1421.4385317799617;1421.7156568686305;1422.907511011781;28814.423711526073;29084.854575726986;29142.27144321409;29394.70605294005;29397.706022939496;45715.31427028664;46073.76963115163;46076;46079;46079.76960115178;267103;269006;269259;269738;270224;30501.847490762404;31275.374492510477;31366.686333136375;31436.842815785774;31514;37261.441078384385;38023.809880950415;38042.42936356012;38456;38478.23043539058;32106;32610.803947249948;32968.670313297516;33210;33418.66581334253;32435.18912027218;32452.35095298128;34169;34927.47608785921;35182.120446988;34942.65057349394;35392.949362885236;35508.644913551565;35695.82152089223;35713.28573428569;29712.257193570334;31391.37217255688;31560.842195788875;31610.36779264448;31630.525542116426;23862.16482423107;24105.397365066012;24547.63178552359;24556.140535081187;24624.753752462246 18:20:24 INFO - 2015-11-11 18:20:24,661 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.79056984669506;338.8712289330054;341.46901568061656;342.100276273401;342.3187856166229;11995.940020299908;12512.311822849739;16913.06978116203;17333.739993900086;18528.722069168973;11854.585089521868;11928.64214073577;12119.818202726967;12200.81698774517;12233.143679942408;4409.250427427337;4541;4543.204939135655;4547.590716835484;4556.476005259388;4404.911901761963;4525.818967241306;4526.207913615121;4526.23054080807;4527.4340707411575;4470.463544374679;4470.865874023784;4594.150082234781;4708.034852855157;4728.2671185966055;4679.60223381013;4679.766011699418;4680.227762419231;4696.060787842411;4698.459677137122;3984.362501999666;4134.462519872427;4138.399932009872;4138.710290279681;4141.088960428701;12611;12631;12877;13561.932190339085;13598.252096134709;1814.23802003159;1924.3649595633408;1967.0558132096673;1975.7431533900644;2018.485286252011;9244.95377523108;9598;9791.804163916682;9830.164436022947;10096.747581310527;1595.8563729264422;1607.3891921070035;1639.2541393665972;1668.8080870699903;1693.6612677464434;54463;55237.44762552363;55693.72153139249;58486;59410.70294648499;6559.8360040998405;6638.734450622018;6654.13496245485;6674.23246326669;6752.76365327221;7637.656305466267;7641.159472458025;7642;7645.961770191114;7652.73215437457;5669.744861481243;5677.063284558001;5680.971595141998;5708.457696518824;5735.2257445245195;5792.478676919098;5875.383084776123;5888.087346461305;6136.78521251763;6217.285012223561;2993.9550906736417;3008.4584774740756;3029.4546981543535;3038.8328641924904;3043.832589207615;1063.8191507443753;1064.0955188090215;1064.7444613292755;1071.796358691846;1127.1715289262386;424.5648210584176;443.4412640073531;445.73256046371915;448.03225033927214;479.0443066083117;11271.323720576627;11938.985186259091;11958.103142264192;11975.341356225317;12027.879721202851;452.5158080853521;452.91847467456176;456.4363011680572;469.50936271595583;491.96556241063496;6322.71547780351;6510.479161667055;6593.505487088488;6606.669666516655;6740.258571557125;547766;551905;554146;554809;557823;68681;71410.64294678494;71418;71518;71761.2823871765;489.9436564795023;492.266522880912;493.2084005171791;493.2576472409073;494.8713334533047;10832.295900766425;11275.830862537232;11277;11314.717132071764;11368.147388945697;31598;32872.83563582167;33078.834605826814;34890.47664285089;35716.46425303571;44378;45146.097078057595;45533.77233113946;45536;45612.543874560826;6323.525735569759;6399.424051835357;6401.3598640135615;6411.679416029273;6418.775342862978;11931;12045.277283363026;12191.695207619881;12214.450349734461;12227.938860305641;8377.874331885148;9970.102690757867;10335.586576537155;10365.481725913523;10492.108170805566;9786.41281523111;9848.015198480094;10132.544035518567;10224.437655928996;10250.48747562604;10117.645882394081;10411.375317480975;10414.635487757892;10541.367517948947;10556.947215263874;6226.221722284715;6274.372562743689;6284.780032698834;6372.522060845363;6374.07575901501;9893.752656183366;9955.452450115314;10452.895471045193;10583.576656933636;10598.735031624272 18:20:24 INFO - 2015-11-11 18:20:24,664 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1455.3378212913126;1744.904030278335;1777.6533575952687;1786.919588618512;1817.9454616361506;7103.431725461951;7259.056322678044;7988.241117093874;8299.087100418956;8307.293880020197;7680.193579674137;7833.295003449688;7961.880571791413;7976.840463190732;7976.840463190732;2229.2754854672257;2256.2103263857603;2264.2527965771337;2265.909363625453;2266.6260067088992;2248.4940888300166;2261.366817291161;2316.096722278313;2316.5714342846545;2321.791038806507;2241.1483636218295;2248.5615305015526;2252.4706693926914;2265.66015097735;2275.8975846086964;2250.4823890505113;2273.318004598622;2297.7242730872317;2297.7587353327913;2302.82728795341;2295.735990361113;2324.6861673674007;2325.2442956039354;2326.26722582386;2333.801626861719;7531.623418829036;7588.772336829904;7606.429517786189;7609.048868891388;7628.504147230467;4796.448408433005;4865.9756701216265;4867.780949857265;4869.391326084239;4877.707337559757;2968.3766409054124;2975.5239161734235;3064.8161110333454;3074.200707815962;3077.2460747117098;842.5913431985482;850.3664769746516;852.4033176776281;901.7970956534792;910.426431348253;10868.61959831402;10869.347839129678;10871.075958543533;10888.61889833852;10892.237543371966;4429.224885645;4469.150861336336;4481.887952801206;4484.506704262529;4520.50274469808;9426.340156189139;9429.528523573794;9484.762880928032;9503.334766566411;9526.809463810685;5054.82308119214;5066.518680725325;5073.797048118034;5078.162103252996;5086.364204474441;4032.1129351542613;4120.114175452292;4413.602775750198;4584.541545845455;4587.632989360844;3701.2227432239533;3739.3269211542183;3752.6622603965775;3752.849886004584;3769.3026790043928;1232.617888454582;1244.545740804618;1245.2404033539533;1250.456051617531;1252.6993521554944;1303.5307289375817;1304.341307639636;1308.5158491358259;1326.2771789374815;1352.6550729563899;7624.847503049908;7657.540547567164;7690.846183076307;7736.7292144774665;7796.454248202572;449.5886264068406;454.5749076644677;457.2889157360337;458.4178093820829;465.75315083006063;5960.254968128984;5974;5983.850403739854;6000.789972350947;6003.279606447254;9285.164335209729;9615.663451779154;9621.759456013655;9696.6121355145;9699.321047526606;9451.810963780687;9550.426974381558;9564.856527152098;9584.137427631547;9585.137337639506;7386.2613738625705;7512.924870751332;7563.394928405714;7585.544867308089;7589;7221.386182174364;7305.817354566178;7336.229695882069;7350.044494215717;7379.409647228102;8450.577471126297;8535.231829135408;8561.61472733716;8624.913750862412;8666.523341216294;8602;8758.518281494578;8778.956105219433;8836.558172091241;8867.423617464845;6918.446524277945;7181.605011724197;7213.855722885618;7216.170140433707;7236.89144662841;7675.923240767745;7761.650725717243;7770.650320735694;7773.883391749241;7794.025746781653;7127.10911136108;7271.3455788979245;7276.927230727837;7359.632018399166;7383.741569045058;7080;7110.5022648414115;7111.0756399768225;7115.181754098345;7222.494425390172;7232.240614735377;7267.927320726725;7280.890786638311;7327.706891724484;7333.853322933618;6492.383223593751;6536.673166341759;6539.509536784665;6544.6727663617585;6556.704948277244;6479.935200647933;6696.263411024881;6710.188249172794;6710.731570737116;6733.326667333227 18:20:24 INFO - 2015-11-11 18:20:24,666 DEBUG : BROWSER_OUTPUT: |4;prototype.html;305.3343710710651;309.2454411236584;309.39358856640996;321.50969771099074;328.2302999466252;6162.044883043124;6188.690565471726;6219.533534984872;6292.528060395466;6299.77950771723;6076.453119219269;6125.877482450348;6129.417705317999;6153.8769124652035;6193.752249909998;4799.208130658446;4833.32333473314;4833.564979151875;4835.661503694742;4840.757962101899;4815.831445899395;4820.156472617296;4821.083994041139;4831.565159135677;4835;4644.883877903046;4745.833895813647;4785.1147537705465;4888;4891.730954797485;4860.951390486085;4870.683405578626;4880.829170978998;4881.511848815126;4884.998575292075;4199.328107502815;4200.621944025022;4214.304639734441;4217.34631132175;4229.196452674013;6110.969445152746;6115.87768244637;6119.785807496761;6134.938650613526;6160.383961603804;5239.266502689588;5403.918941215885;5410.83767486976;5424.430434804328;5433.809816656398;6535.411812936859;6571.34286571339;6575.506836987197;6586.04502347157;6592.373724496165;4492.820287188509;4495.011097558532;4495.393121928563;4501.077279157765;4502.347159661864;6649.501287403464;6835.316468353125;6854.177498700188;6861.142357205349;6875.759348422781;4587.174308624413;4590.288505281686;4596.5863072323655;4596.954030459719;4598.356230127785;4695.107929493385;4696.577308042292;4702.412198475191;4707.152712511713;4720.622350211975;5381.892362152813;5399.83800485986;5408.4050754416985;5417.187421886749;5417.864553386197;6383.553151279459;6573.3426657333885;6575.769848055295;6583.3416658334745;6593.307702691244;1584.5404832598647;1625.3742309210802;1630.5678995066316;1632.9918350408173;1651.3229575873834;999.6351331763854;1000.3397757480028;1003.3478239144614;1007.2495990487134;1014.1481155828991;6204.534659900525;6212.751489940442;6225.8132256032395;6227.96886015567;6232.657203853741;6766.424853887376;6767.424768894601;6773.356531129535;6792.184937807495;6793.184817821893;6066.696665166724;6193.4425901669065;6208.255009398901;6224.9377506224355;6227.564070515111;3740.3828368318923;3751.5498140222803;3754.1553150541454;3756.1360886996144;3762.097096696773;6962.686679099453;6963.7562685305775;6966.9651651741415;6974.895376569356;6982.895256571155;6728.529002969745;6890.276520965327;6915.757948471779;6916.412104971134;6958.721651133999;6954.965225173842;6966.79099627012;6973.965130174317;6977.406920411822;6985.196702379189;6746.0555522227905;6749.055132281386;6762.52662313653;6762.695678694372;6776.728930842908;6536.4117229447675;6623.437007854386;6626.701798418986;6643.468522518284;6644.90032649501;6961.825954351182;6984.4063254623925;6989.615571143636;7006.404455621329;7043.7534686285735;4390.4511936008;4415.492218394926;4422.137683151883;4430.202563538594;4446.5108838027145;6722.731090756511;6755.527113102035;6762.560433571802;6763.830904227434;6771.593704377753;6516.380943810331;6546.705398257185;6549.279579246184;6570.342965703391;6577.6053436792035;6555.475561955128;6567.343265673586;6570.638614876037;6580.539362244788;6589.703463344257;6307.716152773228;6367;6371.840703982438;6417.903731444126;6420.101185834081;6521.250056243403;6531.314212007861;6540.117084193573;6540.8364790880605;6571.145751052332;6380.585261957958;6383.712732926937;6397.0404439332615;6398.360163983751;6405.487560995202 18:20:24 INFO - 2015-11-11 18:20:24,667 DEBUG : BROWSER_OUTPUT: |5;yui.html;662.8177251255908;712.7826013066019;756.1040167401629;778.2839787395594;781.4529829119616;13836.654083647902;13958.930205348985;14071.718565628682;14081.929590352047;14095.647608809784;13170.209787412738;13250.46998120074;13333.666658333546;13364.198148111096;13749.106308089968;894.0478390514098;911.1844898815556;911.8632205169212;911.9772005699845;912.393258483108;894.110360191607;900.3877363392891;900.6847603338812;901.1079031758545;901.5402144906079;939.8543225800012;949.5347279832902;950.2208189284789;950.6435086842434;951.4481600671594;946.4510583861344;947.924166066713;947.9430435064922;948.2508818033814;948.2793077261297;698.8567343694581;700.1283402164287;700.9018737376771;701.0885848397114;701.5790525684599;11557;11648.359340236284;11660.300381977024;11673.883261167364;11688.766224675544;10401;10425.843612345745;10670.73323166927;10812.621558245424;11039.337639741561;9086.586090746965;9112.271018318519;9130.634774609074;9244.121808428188;9375.015623359517;3256.6743325667244;3364.2598628301735;3392.2028323343993;3394.13449570358;3514.1917359007316;41989.37015944763;42594;42739.35890961607;42929.14141717179;48299;5976.073708575178;6072.089186622042;6111.449969502677;6161.106639537242;6343.904841427382;9968.950155249177;9969.80060398788;9985.101340879355;9985.151262142654;9992.200623950066;6238.937610623836;6289.55973081889;6444.033394990789;6449.709763060673;6570.638614876228;3803.5625903021505;3835.4246862970776;3875.050612599931;3878.204967981557;3926.4306675532457;2798.734120258572;2819.5488721804413;2824.675162356314;2826.1804076817903;2826.2792987787984;410.16940695092677;410.81102692761067;412.7853516171574;414.8071146916638;415.1613740244689;467.4460763994677;550.8898220355865;551.5064017704133;602.3554796367845;634.7936920500763;8216.34269258458;8317.500949942902;8412.411131220755;8428.30612356669;8561.700340488052;553.1591980190088;553.9533706275695;566.2214455124205;569.9401562835925;578.4302462074853;3419.7093247074276;3694.8152592370275;3702.5556933167654;3751.3247615429486;4010.2781499329817;58654.706726466946;59195;59434.70282648559;59513.10730339048;59527.40472595305;51601.48398516042;51788.223176652384;51955.48044519506;53041.469585304425;53108.20337694938;43450.34824477635;44931.32603010957;46691.766541167075;47906.5209347916;48541.75729121332;7548.584827834522;7549.245075492407;7890.881636775338;7989.360851131779;8102.270795628186;33441.83279083687;33499;34076.82961585176;34481.65518344885;34515.654843451244;42677.57322426736;44553.331700023875;44934;45043;45353.546464534935;7193.964030179815;7394.55632662042;7492.850142997218;7599.240075992357;7601.661067007672;10897.509612067635;10901;10938.671839844817;11343.376114313793;11749.177557571229;10075.34510256831;10722.785544289227;10752.784944301227;10848.294860834021;10851.283271847506;9329.58016889228;9658.227341812779;9773.951130244302;10041.246906482189;10047.648332308334;10314.27800053989;10662.253642244968;10790.244682872437;10920.890791092304;11093.500792464198;8903;9008.819823603622;9254.768630784285;9284.442933424016;9366.391184572982;8533.573321334032;9124.908750912406;9344.906550934404;9355.53222338894;9446.102620251066 18:20:24 INFO - 2015-11-11 18:20:24,667 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:20:24 INFO - 2015-11-11 18:20:24,667 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:20:24 INFO - 2015-11-11 18:20:24,667 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,286 18:20:24 INFO - 2015-11-11 18:20:24,668 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:20:24 INFO - 2015-11-11 18:20:24,668 DEBUG : BROWSER_OUTPUT: __startTimestamp1447294824654__endTimestamp 18:20:24 INFO - 2015-11-11 18:20:24,668 DEBUG : BROWSER_OUTPUT: 18:20:24 INFO - 2015-11-11 18:20:24,668 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:20:24 INFO - 2015-11-11 18:20:24,668 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:20:24 INFO - 2015-11-11 18:20:24,668 DEBUG : BROWSER_OUTPUT: 18:20:24 INFO - 2015-11-11 18:20:24,670 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5510.39 Median:5712.89 stddev:705.03 (12.3%) stddev-sans-first:682.63 18:20:24 INFO - 2015-11-11 18:20:24,670 DEBUG : BROWSER_OUTPUT: Values: 3158.9 3189.2 3209.6 3230.2 3246.5 5527.1 5546.3 5572.0 5588.6 5595.5 5314.9 5420.4 5444.3 5536.6 5551.9 5173.1 5192.7 5255.3 5265.7 5267.3 749.1 5223.5 5250.5 5258.3 5336.7 5208.3 5228.7 5237.3 5241.6 5251.3 5249.0 5261.1 5272.6 5279.7 5285.0 5012.3 5064.5 5134.1 5146.4 5182.9 5460.3 5481.7 5484.5 5504.6 5568.6 5750.5 5891.7 5911.0 5915.5 5925.9 5891.3 5925.2 5940.7 5974.3 5993.1 5586.0 5586.7 5587.2 5589.3 5601.8 5820.0 5959.7 6095.1 6101.8 6106.7 5692.2 5767.1 5773.4 5786.6 5827.1 5967.3 6004.7 6019.7 6022.2 6030.4 5672.3 5771.2 5775.0 5880.1 5892.2 5887.1 5893.8 5893.9 5906.6 5916.6 4565.0 4569.7 4573.7 4582.1 4616.9 4025.4 4079.7 4113.8 4164.6 4174.0 5583.8 5588.8 5609.1 5628.0 5635.4 6003.2 6012.6 6027.1 6028.1 6047.0 5386.8 5504.5 5583.1 5646.5 5712.9 5291.8 5294.2 5298.3 5303.5 5305.5 5930.2 6184.6 6220.2 6223.7 6229.9 5857.2 5893.3 5927.9 5929.1 5984.8 6157.7 6161.3 6175.1 6178.0 6187.9 5731.3 5861.4 5908.8 5917.9 5927.1 5735.3 5855.5 5920.9 5924.8 5973.8 5844.1 5851.0 5856.0 5860.2 5867.1 5611.5 5684.8 5723.6 5858.1 5863.0 5592.7 5710.7 5715.7 5737.1 5743.6 5842.6 5843.8 5854.6 5855.1 5865.9 5443.5 5627.5 5678.4 5739.2 5800.2 18:20:24 INFO - 2015-11-11 18:20:24,670 DEBUG : BROWSER_OUTPUT: 18:20:24 INFO - 2015-11-11 18:20:24,671 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44652.67 Median:17933.38 stddev:72069.65 (401.9%) stddev-sans-first:72195.74 18:20:24 INFO - 2015-11-11 18:20:24,672 DEBUG : BROWSER_OUTPUT: Values: 547.4 578.7 579.0 581.8 590.5 38426.6 39635.2 39695.2 39721.2 39762.2 42308.8 42938.1 42959.0 43009.4 43020.1 9293.3 9431.4 9465.8 9479.3 9493.3 9179.5 9317.5 9318.2 9325.6 9327.3 9384.9 9455.9 9460.0 9464.5 9481.8 9227.1 9299.3 9320.1 9331.7 9335.8 9146.8 9272.0 9283.0 9284.1 9306.1 39275.2 39604.6 39663.6 39733.0 39736.8 2828.7 2871.3 2977.2 3116.4 3256.0 26866.7 27284.7 27613.0 27809.7 28319.7 2351.5 2385.0 2421.6 2444.0 2499.8 256897.0 257679.0 257843.0 259047.0 259295.0 56353.0 56660.4 56704.0 56713.4 56770.1 56783.4 57811.4 60860.0 62168.8 62219.4 16244.2 16331.6 16456.7 16458.3 16467.7 12443.3 12522.4 12526.5 12527.2 12531.2 18858.8 19154.8 19200.1 19216.3 19233.1 8768.5 8997.5 8999.2 9003.7 9011.5 981.6 1039.5 1082.7 1085.0 1090.5 28090.3 28432.3 28742.4 29149.7 29319.7 980.1 1016.9 1019.4 1031.2 1089.9 13820.7 15223.2 15419.0 15447.5 15595.2 297652.0 299925.0 301064.0 301798.0 302644.0 54220.5 54311.0 54431.0 54489.2 54512.0 1377.1 1400.8 1421.4 1421.7 1422.9 28814.4 29084.9 29142.3 29394.7 29397.7 45715.3 46073.8 46076.0 46079.0 46079.8 267103.0 269006.0 269259.0 269738.0 270224.0 30501.8 31275.4 31366.7 31436.8 31514.0 37261.4 38023.8 38042.4 38456.0 38478.2 32106.0 32610.8 32968.7 33210.0 33418.7 32435.2 32452.4 34169.0 34927.5 35182.1 34942.7 35392.9 35508.6 35695.8 35713.3 29712.3 31391.4 31560.8 31610.4 31630.5 23862.2 24105.4 24547.6 24556.1 24624.8 18:20:24 INFO - 2015-11-11 18:20:24,672 DEBUG : BROWSER_OUTPUT: 18:20:24 INFO - 2015-11-11 18:20:24,672 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26749.15 Median:452.72 stddev:90576.88 (20007.4%) stddev-sans-first:90809.26 18:20:24 INFO - 2015-11-11 18:20:24,674 DEBUG : BROWSER_OUTPUT: Values: 337.8 338.9 341.5 342.1 342.3 11995.9 12512.3 16913.1 17333.7 18528.7 11854.6 11928.6 12119.8 12200.8 12233.1 4409.3 4541.0 4543.2 4547.6 4556.5 4404.9 4525.8 4526.2 4526.2 4527.4 4470.5 4470.9 4594.2 4708.0 4728.3 4679.6 4679.8 4680.2 4696.1 4698.5 3984.4 4134.5 4138.4 4138.7 4141.1 12611.0 12631.0 12877.0 13561.9 13598.3 1814.2 1924.4 1967.1 1975.7 2018.5 9245.0 9598.0 9791.8 9830.2 10096.7 1595.9 1607.4 1639.3 1668.8 1693.7 54463.0 55237.4 55693.7 58486.0 59410.7 6559.8 6638.7 6654.1 6674.2 6752.8 7637.7 7641.2 7642.0 7646.0 7652.7 5669.7 5677.1 5681.0 5708.5 5735.2 5792.5 5875.4 5888.1 6136.8 6217.3 2994.0 3008.5 3029.5 3038.8 3043.8 1063.8 1064.1 1064.7 1071.8 1127.2 424.6 443.4 445.7 448.0 479.0 11271.3 11939.0 11958.1 11975.3 12027.9 452.5 452.9 456.4 469.5 492.0 6322.7 6510.5 6593.5 6606.7 6740.3 547766.0 551905.0 554146.0 554809.0 557823.0 68681.0 71410.6 71418.0 71518.0 71761.3 489.9 492.3 493.2 493.3 494.9 10832.3 11275.8 11277.0 11314.7 11368.1 31598.0 32872.8 33078.8 34890.5 35716.5 44378.0 45146.1 45533.8 45536.0 45612.5 6323.5 6399.4 6401.4 6411.7 6418.8 11931.0 12045.3 12191.7 12214.5 12227.9 8377.9 9970.1 10335.6 10365.5 10492.1 9786.4 9848.0 10132.5 10224.4 10250.5 10117.6 10411.4 10414.6 10541.4 10556.9 6226.2 6274.4 6284.8 6372.5 6374.1 9893.8 9955.5 10452.9 10583.6 10598.7 18:20:24 INFO - 2015-11-11 18:20:24,674 DEBUG : BROWSER_OUTPUT: 18:20:24 INFO - 2015-11-11 18:20:24,674 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5582.73 Median:6626.48 stddev:2922.87 (44.1%) stddev-sans-first:2914.60 18:20:24 INFO - 2015-11-11 18:20:24,675 DEBUG : BROWSER_OUTPUT: Values: 1455.3 1744.9 1777.7 1786.9 1817.9 7103.4 7259.1 7988.2 8299.1 8307.3 7680.2 7833.3 7961.9 7976.8 7976.8 2229.3 2256.2 2264.3 2265.9 2266.6 2248.5 2261.4 2316.1 2316.6 2321.8 2241.1 2248.6 2252.5 2265.7 2275.9 2250.5 2273.3 2297.7 2297.8 2302.8 2295.7 2324.7 2325.2 2326.3 2333.8 7531.6 7588.8 7606.4 7609.0 7628.5 4796.4 4866.0 4867.8 4869.4 4877.7 2968.4 2975.5 3064.8 3074.2 3077.2 842.6 850.4 852.4 901.8 910.4 10868.6 10869.3 10871.1 10888.6 10892.2 4429.2 4469.2 4481.9 4484.5 4520.5 9426.3 9429.5 9484.8 9503.3 9526.8 5054.8 5066.5 5073.8 5078.2 5086.4 4032.1 4120.1 4413.6 4584.5 4587.6 3701.2 3739.3 3752.7 3752.8 3769.3 1232.6 1244.5 1245.2 1250.5 1252.7 1303.5 1304.3 1308.5 1326.3 1352.7 7624.8 7657.5 7690.8 7736.7 7796.5 449.6 454.6 457.3 458.4 465.8 5960.3 5974.0 5983.9 6000.8 6003.3 9285.2 9615.7 9621.8 9696.6 9699.3 9451.8 9550.4 9564.9 9584.1 9585.1 7386.3 7512.9 7563.4 7585.5 7589.0 7221.4 7305.8 7336.2 7350.0 7379.4 8450.6 8535.2 8561.6 8624.9 8666.5 8602.0 8758.5 8779.0 8836.6 8867.4 6918.4 7181.6 7213.9 7216.2 7236.9 7675.9 7761.7 7770.7 7773.9 7794.0 7127.1 7271.3 7276.9 7359.6 7383.7 7080.0 7110.5 7111.1 7115.2 7222.5 7232.2 7267.9 7280.9 7327.7 7333.9 6492.4 6536.7 6539.5 6544.7 6556.7 6479.9 6696.3 6710.2 6710.7 6733.3 18:20:24 INFO - 2015-11-11 18:20:24,675 DEBUG : BROWSER_OUTPUT: 18:20:24 INFO - 2015-11-11 18:20:24,675 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5478.60 Median:6216.14 stddev:1654.62 (26.6%) stddev-sans-first:1613.06 18:20:24 INFO - 2015-11-11 18:20:24,676 DEBUG : BROWSER_OUTPUT: Values: 305.3 309.2 309.4 321.5 328.2 6162.0 6188.7 6219.5 6292.5 6299.8 6076.5 6125.9 6129.4 6153.9 6193.8 4799.2 4833.3 4833.6 4835.7 4840.8 4815.8 4820.2 4821.1 4831.6 4835.0 4644.9 4745.8 4785.1 4888.0 4891.7 4861.0 4870.7 4880.8 4881.5 4885.0 4199.3 4200.6 4214.3 4217.3 4229.2 6111.0 6115.9 6119.8 6134.9 6160.4 5239.3 5403.9 5410.8 5424.4 5433.8 6535.4 6571.3 6575.5 6586.0 6592.4 4492.8 4495.0 4495.4 4501.1 4502.3 6649.5 6835.3 6854.2 6861.1 6875.8 4587.2 4590.3 4596.6 4597.0 4598.4 4695.1 4696.6 4702.4 4707.2 4720.6 5381.9 5399.8 5408.4 5417.2 5417.9 6383.6 6573.3 6575.8 6583.3 6593.3 1584.5 1625.4 1630.6 1633.0 1651.3 999.6 1000.3 1003.3 1007.2 1014.1 6204.5 6212.8 6225.8 6228.0 6232.7 6766.4 6767.4 6773.4 6792.2 6793.2 6066.7 6193.4 6208.3 6224.9 6227.6 3740.4 3751.5 3754.2 3756.1 3762.1 6962.7 6963.8 6967.0 6974.9 6982.9 6728.5 6890.3 6915.8 6916.4 6958.7 6955.0 6966.8 6974.0 6977.4 6985.2 6746.1 6749.1 6762.5 6762.7 6776.7 6536.4 6623.4 6626.7 6643.5 6644.9 6961.8 6984.4 6989.6 7006.4 7043.8 4390.5 4415.5 4422.1 4430.2 4446.5 6722.7 6755.5 6762.6 6763.8 6771.6 6516.4 6546.7 6549.3 6570.3 6577.6 6555.5 6567.3 6570.6 6580.5 6589.7 6307.7 6367.0 6371.8 6417.9 6420.1 6521.3 6531.3 6540.1 6540.8 6571.1 6380.6 6383.7 6397.0 6398.4 6405.5 18:20:24 INFO - 2015-11-11 18:20:24,676 DEBUG : BROWSER_OUTPUT: 18:20:24 INFO - 2015-11-11 18:20:24,676 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12952.34 Median:553.56 stddev:15992.64 (2889.1%) stddev-sans-first:16010.88 18:20:24 INFO - 2015-11-11 18:20:24,678 DEBUG : BROWSER_OUTPUT: Values: 662.8 712.8 756.1 778.3 781.5 13836.7 13958.9 14071.7 14081.9 14095.6 13170.2 13250.5 13333.7 13364.2 13749.1 894.0 911.2 911.9 912.0 912.4 894.1 900.4 900.7 901.1 901.5 939.9 949.5 950.2 950.6 951.4 946.5 947.9 947.9 948.3 948.3 698.9 700.1 700.9 701.1 701.6 11557.0 11648.4 11660.3 11673.9 11688.8 10401.0 10425.8 10670.7 10812.6 11039.3 9086.6 9112.3 9130.6 9244.1 9375.0 3256.7 3364.3 3392.2 3394.1 3514.2 41989.4 42594.0 42739.4 42929.1 48299.0 5976.1 6072.1 6111.4 6161.1 6343.9 9969.0 9969.8 9985.1 9985.2 9992.2 6238.9 6289.6 6444.0 6449.7 6570.6 3803.6 3835.4 3875.1 3878.2 3926.4 2798.7 2819.5 2824.7 2826.2 2826.3 410.2 410.8 412.8 414.8 415.2 467.4 550.9 551.5 602.4 634.8 8216.3 8317.5 8412.4 8428.3 8561.7 553.2 554.0 566.2 569.9 578.4 3419.7 3694.8 3702.6 3751.3 4010.3 58654.7 59195.0 59434.7 59513.1 59527.4 51601.5 51788.2 51955.5 53041.5 53108.2 43450.3 44931.3 46691.8 47906.5 48541.8 7548.6 7549.2 7890.9 7989.4 8102.3 33441.8 33499.0 34076.8 34481.7 34515.7 42677.6 44553.3 44934.0 45043.0 45353.5 7194.0 7394.6 7492.9 7599.2 7601.7 10897.5 10901.0 10938.7 11343.4 11749.2 10075.3 10722.8 10752.8 10848.3 10851.3 9329.6 9658.2 9774.0 10041.2 10047.6 10314.3 10662.3 10790.2 10920.9 11093.5 8903.0 9008.8 9254.8 9284.4 9366.4 8533.6 9124.9 9344.9 9355.5 9446.1 18:20:24 INFO - 2015-11-11 18:20:24,678 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:20:24 INFO - 2015-11-11 18:20:24,678 DEBUG : BROWSER_OUTPUT: 18:20:25 INFO - 2015-11-11 18:20:25,318 INFO : Browser exited with error code: 0 18:20:25 INFO - 2015-11-11 18:20:25,345 INFO : Completed test dromaeo_css (00:18:32) 18:20:25 INFO - 2015-11-11 18:20:25,345 INFO : Starting test kraken 18:20:25 INFO - 2015-11-11 18:20:25,345 DEBUG : operating with platform_type : mac_ 18:20:25 INFO - 2015-11-11 18:20:25,346 INFO : Initialising browser for kraken test... 18:20:25 INFO - 2015-11-11 18:20:25,358 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpaVvi5c/profile http://localhost:49275/getInfo.html 18:20:28 INFO - 2015-11-11 18:20:28,283 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:20:28 INFO - 2015-11-11 18:20:28,284 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:20:28 INFO - 2015-11-11 18:20:28,284 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:20:28 INFO - 2015-11-11 18:20:28,284 DEBUG : BROWSER_OUTPUT: __metrics 18:20:28 INFO - 2015-11-11 18:20:28,885 INFO : Browser initialized. 18:20:28 INFO - 2015-11-11 18:20:28,886 INFO : Running cycle 1/1 for kraken test... 18:20:28 INFO - 2015-11-11 18:20:28,886 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpaVvi5c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:20:40 INFO - 2015-11-11 18:20:40,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 240107520 18:20:40 INFO - 2015-11-11 18:20:40,937 DEBUG : BROWSER_OUTPUT: 18:20:43 INFO - 2015-11-11 18:20:43,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 18:20:44 INFO - 2015-11-11 18:20:44,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 259706880 18:20:44 INFO - 2015-11-11 18:20:44,076 DEBUG : BROWSER_OUTPUT: 18:20:46 INFO - 2015-11-11 18:20:46,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 18:20:47 INFO - 2015-11-11 18:20:47,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 267100160 18:20:47 INFO - 2015-11-11 18:20:47,280 DEBUG : BROWSER_OUTPUT: 18:20:50 INFO - 2015-11-11 18:20:50,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 18:20:50 INFO - 2015-11-11 18:20:50,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 266387456 18:20:50 INFO - 2015-11-11 18:20:50,727 DEBUG : BROWSER_OUTPUT: 18:20:52 INFO - 2015-11-11 18:20:52,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 18:20:53 INFO - 2015-11-11 18:20:53,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 266825728 18:20:53 INFO - 2015-11-11 18:20:53,291 DEBUG : BROWSER_OUTPUT: 18:20:55 INFO - 2015-11-11 18:20:55,404 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:20:55 INFO - 2015-11-11 18:20:55,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 267304960 18:20:55 INFO - 2015-11-11 18:20:55,990 DEBUG : BROWSER_OUTPUT: 18:20:59 INFO - 2015-11-11 18:20:59,011 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 18:20:59 INFO - 2015-11-11 18:20:59,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 266919936 18:20:59 INFO - 2015-11-11 18:20:59,598 DEBUG : BROWSER_OUTPUT: 18:21:02 INFO - 2015-11-11 18:21:02,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 18:21:03 INFO - 2015-11-11 18:21:03,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 267018240 18:21:03 INFO - 2015-11-11 18:21:03,291 DEBUG : BROWSER_OUTPUT: 18:21:06 INFO - 2015-11-11 18:21:06,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 18:21:06 INFO - 2015-11-11 18:21:06,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 270487552 18:21:06 INFO - 2015-11-11 18:21:06,736 DEBUG : BROWSER_OUTPUT: 18:21:08 INFO - 2015-11-11 18:21:08,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:21:08 INFO - 2015-11-11 18:21:08,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 271724544 18:21:08 INFO - 2015-11-11 18:21:08,937 DEBUG : BROWSER_OUTPUT: 18:21:10 INFO - 2015-11-11 18:21:10,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:21:11 INFO - 2015-11-11 18:21:11,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 271630336 18:21:11 INFO - 2015-11-11 18:21:11,377 DEBUG : BROWSER_OUTPUT: 18:21:13 INFO - 2015-11-11 18:21:13,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:21:14 INFO - 2015-11-11 18:21:14,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 271347712 18:21:14 INFO - 2015-11-11 18:21:14,042 DEBUG : BROWSER_OUTPUT: 18:21:16 INFO - 2015-11-11 18:21:16,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:21:17 INFO - 2015-11-11 18:21:17,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 271110144 18:21:17 INFO - 2015-11-11 18:21:17,212 DEBUG : BROWSER_OUTPUT: 18:21:19 INFO - 2015-11-11 18:21:19,801 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:21:20 INFO - 2015-11-11 18:21:20,387 DEBUG : BROWSER_OUTPUT: RSS: Main: 271548416 18:21:20 INFO - 2015-11-11 18:21:20,388 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 18:21:22 INFO - 2015-11-11 18:21:22,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 271654912 18:21:22 INFO - 2015-11-11 18:21:22,370 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,370 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:21:22 INFO - 2015-11-11 18:21:22,370 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:21:22 INFO - 2015-11-11 18:21:22,370 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:21:22 INFO - 2015-11-11 18:21:22,370 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:21:22 INFO - 2015-11-11 18:21:22,370 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;100;110;109;108;118;108;108;111;110 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;128;152;160;128;147;151;128;163;129 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;166;167;167;167;168;169;171;169;169 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;71;77;67;72;71;72;125;64;68 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;89;89;128;86;89;88;126;88;89;130 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;116;121;116;121;115;121;116;121;121 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;127;126;126;127;127;126;127;126;126;127 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;104;106;104;106;110;104;105;106;104;104 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;63;66;64;63;65;64;65;71;63;64 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;68;67;69;69;68;68;70;74 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;89;87;87;88;87;86;87;87;86;88 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;125;131;136;129;126;130;135;132;135 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;155;157;154;157;157;159;155;145;142 18:21:22 INFO - 2015-11-11 18:21:22,371 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;71;71;73;73;73;70;73;76;75 18:21:22 INFO - 2015-11-11 18:21:22,372 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:21:22 INFO - 2015-11-11 18:21:22,372 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:21:22 INFO - 2015-11-11 18:21:22,372 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,708 18:21:22 INFO - 2015-11-11 18:21:22,372 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:21:22 INFO - 2015-11-11 18:21:22,372 DEBUG : BROWSER_OUTPUT: __startTimestamp1447294882363__endTimestamp 18:21:22 INFO - 2015-11-11 18:21:22,372 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,372 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:21:22 INFO - 2015-11-11 18:21:22,372 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:21:22 INFO - 2015-11-11 18:21:22,372 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,373 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:4.37 (4.0%) stddev-sans-first:4.62 18:21:22 INFO - 2015-11-11 18:21:22,373 DEBUG : BROWSER_OUTPUT: Values: 110.0 100.0 110.0 109.0 108.0 118.0 108.0 108.0 111.0 110.0 18:21:22 INFO - 2015-11-11 18:21:22,373 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,373 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:151.50 stddev:14.27 (9.4%) stddev-sans-first:14.67 18:21:22 INFO - 2015-11-11 18:21:22,373 DEBUG : BROWSER_OUTPUT: Values: 154.0 128.0 152.0 160.0 128.0 147.0 151.0 128.0 163.0 129.0 18:21:22 INFO - 2015-11-11 18:21:22,373 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,373 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:167.70 Median:168.50 stddev:1.95 (1.2%) stddev-sans-first:1.54 18:21:22 INFO - 2015-11-11 18:21:22,373 DEBUG : BROWSER_OUTPUT: Values: 164.0 166.0 167.0 167.0 167.0 168.0 169.0 171.0 169.0 169.0 18:21:22 INFO - 2015-11-11 18:21:22,373 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,374 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.10 Median:71.50 stddev:17.57 (24.6%) stddev-sans-first:18.61 18:21:22 INFO - 2015-11-11 18:21:22,374 DEBUG : BROWSER_OUTPUT: Values: 74.0 71.0 77.0 67.0 72.0 71.0 72.0 125.0 64.0 68.0 18:21:22 INFO - 2015-11-11 18:21:22,374 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,374 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:100.20 Median:88.50 stddev:19.23 (21.7%) stddev-sans-first:19.96 18:21:22 INFO - 2015-11-11 18:21:22,374 DEBUG : BROWSER_OUTPUT: Values: 89.0 89.0 128.0 86.0 89.0 88.0 126.0 88.0 89.0 130.0 18:21:22 INFO - 2015-11-11 18:21:22,374 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,374 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:118.90 Median:121.00 stddev:2.73 (2.3%) stddev-sans-first:2.78 18:21:22 INFO - 2015-11-11 18:21:22,374 DEBUG : BROWSER_OUTPUT: Values: 121.0 116.0 121.0 116.0 121.0 115.0 121.0 116.0 121.0 121.0 18:21:22 INFO - 2015-11-11 18:21:22,374 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,375 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:126.50 Median:127.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 18:21:22 INFO - 2015-11-11 18:21:22,375 DEBUG : BROWSER_OUTPUT: Values: 127.0 126.0 126.0 127.0 127.0 126.0 127.0 126.0 126.0 127.0 18:21:22 INFO - 2015-11-11 18:21:22,375 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,375 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:105.30 Median:105.50 stddev:1.89 (1.8%) stddev-sans-first:1.94 18:21:22 INFO - 2015-11-11 18:21:22,375 DEBUG : BROWSER_OUTPUT: Values: 104.0 106.0 104.0 106.0 110.0 104.0 105.0 106.0 104.0 104.0 18:21:22 INFO - 2015-11-11 18:21:22,375 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,375 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:64.80 Median:64.50 stddev:2.39 (3.7%) stddev-sans-first:2.45 18:21:22 INFO - 2015-11-11 18:21:22,375 DEBUG : BROWSER_OUTPUT: Values: 63.0 66.0 64.0 63.0 65.0 64.0 65.0 71.0 63.0 64.0 18:21:22 INFO - 2015-11-11 18:21:22,376 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,376 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.00 stddev:1.93 (2.8%) stddev-sans-first:2.05 18:21:22 INFO - 2015-11-11 18:21:22,376 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 68.0 67.0 69.0 69.0 68.0 68.0 70.0 74.0 18:21:22 INFO - 2015-11-11 18:21:22,376 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,376 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.00 stddev:0.92 (1.1%) stddev-sans-first:0.71 18:21:22 INFO - 2015-11-11 18:21:22,376 DEBUG : BROWSER_OUTPUT: Values: 89.0 87.0 87.0 88.0 87.0 86.0 87.0 87.0 86.0 88.0 18:21:22 INFO - 2015-11-11 18:21:22,376 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,376 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:131.50 stddev:3.83 (2.9%) stddev-sans-first:3.94 18:21:22 INFO - 2015-11-11 18:21:22,376 DEBUG : BROWSER_OUTPUT: Values: 128.0 125.0 131.0 136.0 129.0 126.0 130.0 135.0 132.0 135.0 18:21:22 INFO - 2015-11-11 18:21:22,376 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,377 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.60 Median:156.00 stddev:6.15 (3.9%) stddev-sans-first:5.88 18:21:22 INFO - 2015-11-11 18:21:22,377 DEBUG : BROWSER_OUTPUT: Values: 145.0 155.0 157.0 154.0 157.0 157.0 159.0 155.0 145.0 142.0 18:21:22 INFO - 2015-11-11 18:21:22,377 DEBUG : BROWSER_OUTPUT: 18:21:22 INFO - 2015-11-11 18:21:22,377 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:73.00 stddev:1.83 (2.5%) stddev-sans-first:1.92 18:21:22 INFO - 2015-11-11 18:21:22,377 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 73.0 73.0 73.0 70.0 73.0 76.0 75.0 18:21:22 INFO - 2015-11-11 18:21:22,377 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:21:22 INFO - 2015-11-11 18:21:22,377 DEBUG : BROWSER_OUTPUT: 18:21:23 INFO - 2015-11-11 18:21:23,036 INFO : Browser exited with error code: 0 18:21:23 INFO - 2015-11-11 18:21:23,083 INFO : Completed test kraken (00:00:57) 18:21:23 INFO - 2015-11-11 18:21:23,083 INFO : Starting test v8_7 18:21:23 INFO - 2015-11-11 18:21:23,083 DEBUG : operating with platform_type : mac_ 18:21:23 INFO - 2015-11-11 18:21:23,084 INFO : Initialising browser for v8_7 test... 18:21:23 INFO - 2015-11-11 18:21:23,096 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpnqwp1x/profile http://localhost:49275/getInfo.html 18:21:25 INFO - 2015-11-11 18:21:25,977 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:21:25 INFO - 2015-11-11 18:21:25,977 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:21:25 INFO - 2015-11-11 18:21:25,977 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:21:25 INFO - 2015-11-11 18:21:25,977 DEBUG : BROWSER_OUTPUT: __metrics 18:21:26 INFO - 2015-11-11 18:21:26,620 INFO : Browser initialized. 18:21:26 INFO - 2015-11-11 18:21:26,621 INFO : Running cycle 1/1 for v8_7 test... 18:21:26 INFO - 2015-11-11 18:21:26,621 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/tmpnqwp1x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:21:38 INFO - 2015-11-11 18:21:38,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 241782784 18:21:38 INFO - 2015-11-11 18:21:38,674 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/v8_7/run.html (next: http://localhost:49275/tests/v8_7/run.html) 18:22:00 INFO - 2015-11-11 18:22:00,425 DEBUG : BROWSER_OUTPUT: RSS: Main: 260227072 18:22:00 INFO - 2015-11-11 18:22:00,425 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,425 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:22:00 INFO - 2015-11-11 18:22:00,425 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:22:00 INFO - 2015-11-11 18:22:00,425 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:22:00 INFO - 2015-11-11 18:22:00,425 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:22:00 INFO - 2015-11-11 18:22:00,425 DEBUG : BROWSER_OUTPUT: |0;Richards;166.38935108153078 18:22:00 INFO - 2015-11-11 18:22:00,425 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;196.8503937007874 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: |2;Encrypt;325.8390355164549 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5786.127167630058 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1126.126126126126 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: |5;Earley;793.6507936507936 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: |6;Boyer;12871.794871794871 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: |7;RegExp;28083.333333333332 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: |8;Splay;753.0120481927711 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5809.248554913294 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: __startTimestamp1447294920419__endTimestamp 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:22:00 INFO - 2015-11-11 18:22:00,426 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.39 Median:166.39 stddev:0.00 (0.0%) 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: Values: 166.4 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:196.85 Median:196.85 stddev:0.00 (0.0%) 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: Values: 196.9 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:325.84 Median:325.84 stddev:0.00 (0.0%) 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: Values: 325.8 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5786.13 Median:5786.13 stddev:0.00 (0.0%) 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: Values: 5786.1 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1126.13 Median:1126.13 stddev:0.00 (0.0%) 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: Values: 1126.1 18:22:00 INFO - 2015-11-11 18:22:00,427 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:793.65 Median:793.65 stddev:0.00 (0.0%) 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: Values: 793.7 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12871.79 Median:12871.79 stddev:0.00 (0.0%) 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: Values: 12871.8 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28083.33 Median:28083.33 stddev:0.00 (0.0%) 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: Values: 28083.3 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:753.01 Median:753.01 stddev:0.00 (0.0%) 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: Values: 753.0 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5809.25 Median:5809.25 stddev:0.00 (0.0%) 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: Values: 5809.2 18:22:00 INFO - 2015-11-11 18:22:00,428 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:22:00 INFO - 2015-11-11 18:22:00,429 DEBUG : BROWSER_OUTPUT: 18:22:01 INFO - 2015-11-11 18:22:01,343 INFO : Browser exited with error code: 0 18:22:01 INFO - 2015-11-11 18:22:01,363 INFO : Completed test v8_7 (00:00:38) 18:22:01 INFO - 2015-11-11 18:22:01,465 INFO : Completed test suite (00:20:08) 18:22:01 INFO - 2015-11-11 18:22:01,465 DEBUG : Working with test: dromaeo_css 18:22:01 INFO - 2015-11-11 18:22:01,465 DEBUG : Generating results file: dromaeo_css 18:22:01 INFO - 2015-11-11 18:22:01,466 DEBUG : Working with test: kraken 18:22:01 INFO - 2015-11-11 18:22:01,466 DEBUG : Generating results file: kraken 18:22:01 INFO - 2015-11-11 18:22:01,466 INFO : javascript benchmark 18:22:01 INFO - 2015-11-11 18:22:01,466 DEBUG : Working with test: v8_7 18:22:01 INFO - 2015-11-11 18:22:01,466 DEBUG : Generating results file: v8_7 18:22:01 INFO - 2015-11-11 18:22:01,466 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:22:01 INFO - 2015-11-11 18:22:01,527 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 18:22:01 INFO - 2015-11-11 18:22:01,527 DEBUG : process_Request line: dromaeo_css 6624.82 graph.html#tests=[[72,64,57]] 18:22:01 INFO - 2015-11-11 18:22:01,528 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:22:01 INFO - 2015-11-11 18:22:01,567 DEBUG : process_Request line: kraken 1525.10 graph.html#tests=[[232,64,57]] 18:22:01 INFO - 2015-11-11 18:22:01,567 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:22:01 INFO - 2015-11-11 18:22:01,611 DEBUG : process_Request line: v8_7 19299.89 graph.html#tests=[[230,64,57]] 18:22:01 INFO - 2015-11-11 18:22:01,612 INFO : javascript benchmark 18:22:01 INFO - 2015-11-11 18:22:01,614 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [337.79056984669506, 338.8712289330054, 341.46901568061656, 342.100276273401, 342.3187856166229, 11995.940020299908, 12512.311822849739, 16913.06978116203, 17333.739993900086, 18528.722069168973, 11854.585089521868, 11928.64214073577, 12119.818202726967, 12200.81698774517, 12233.143679942408, 4409.250427427337, 4541.0, 4543.204939135655, 4547.590716835484, 4556.476005259388, 4404.911901761963, 4525.818967241306, 4526.207913615121, 4526.23054080807, 4527.4340707411575, 4470.463544374679, 4470.865874023784, 4594.150082234781, 4708.034852855157, 4728.2671185966055, 4679.60223381013, 4679.766011699418, 4680.227762419231, 4696.060787842411, 4698.459677137122, 3984.362501999666, 4134.462519872427, 4138.399932009872, 4138.710290279681, 4141.088960428701, 12611.0, 12631.0, 12877.0, 13561.932190339085, 13598.252096134709, 1814.23802003159, 1924.3649595633408, 1967.0558132096673, 1975.7431533900644, 2018.485286252011, 9244.95377523108, 9598.0, 9791.804163916682, 9830.164436022947, 10096.747581310527, 1595.8563729264422, 1607.3891921070035, 1639.2541393665972, 1668.8080870699903, 1693.6612677464434, 54463.0, 55237.44762552363, 55693.72153139249, 58486.0, 59410.70294648499, 6559.8360040998405, 6638.734450622018, 6654.13496245485, 6674.23246326669, 6752.76365327221, 7637.656305466267, 7641.159472458025, 7642.0, 7645.961770191114, 7652.73215437457, 5669.744861481243, 5677.063284558001, 5680.971595141998, 5708.457696518824, 5735.2257445245195, 5792.478676919098, 5875.383084776123, 5888.087346461305, 6136.78521251763, 6217.285012223561, 2993.9550906736417, 3008.4584774740756, 3029.4546981543535, 3038.8328641924904, 3043.832589207615, 1063.8191507443753, 1064.0955188090215, 1064.7444613292755, 1071.796358691846, 1127.1715289262386, 424.5648210584176, 443.4412640073531, 445.73256046371915, 448.03225033927214, 479.0443066083117, 11271.323720576627, 11938.985186259091, 11958.103142264192, 11975.341356225317, 12027.879721202851, 452.5158080853521, 452.91847467456176, 456.4363011680572, 469.50936271595583, 491.96556241063496, 6322.71547780351, 6510.479161667055, 6593.505487088488, 6606.669666516655, 6740.258571557125, 547766.0, 551905.0, 554146.0, 554809.0, 557823.0, 68681.0, 71410.64294678494, 71418.0, 71518.0, 71761.2823871765, 489.9436564795023, 492.266522880912, 493.2084005171791, 493.2576472409073, 494.8713334533047, 10832.295900766425, 11275.830862537232, 11277.0, 11314.717132071764, 11368.147388945697, 31598.0, 32872.83563582167, 33078.834605826814, 34890.47664285089, 35716.46425303571, 44378.0, 45146.097078057595, 45533.77233113946, 45536.0, 45612.543874560826, 6323.525735569759, 6399.424051835357, 6401.3598640135615, 6411.679416029273, 6418.775342862978, 11931.0, 12045.277283363026, 12191.695207619881, 12214.450349734461, 12227.938860305641, 8377.874331885148, 9970.102690757867, 10335.586576537155, 10365.481725913523, 10492.108170805566, 9786.41281523111, 9848.015198480094, 10132.544035518567, 10224.437655928996, 10250.48747562604, 10117.645882394081, 10411.375317480975, 10414.635487757892, 10541.367517948947, 10556.947215263874, 6226.221722284715, 6274.372562743689, 6284.780032698834, 6372.522060845363, 6374.07575901501, 9893.752656183366, 9955.452450115314, 10452.895471045193, 10583.576656933636, 10598.735031624272], "dojo.html": [3158.936821263575, 3189.234583699911, 3209.614846218454, 3230.192451887029, 3246.4643333849917, 5527.143292789619, 5546.2512560804325, 5571.972140139299, 5588.608797384185, 5595.468430499106, 5314.867128321794, 5420.430854760242, 5444.3194600674915, 5536.612437129403, 5551.8889622207535, 5173.094708426029, 5192.740362981855, 5255.316808814868, 5265.65773224741, 5267.341582302212, 749.1300821286743, 5223.503767142115, 5250.527452529272, 5258.342707161605, 5336.653117547347, 5208.322918020671, 5228.738563071831, 5237.319148510707, 5241.554467870235, 5251.291075704769, 5249.0, 5261.1319132343115, 5272.551833094191, 5279.683219006872, 5285.048691235576, 5012.323336349583, 5064.468230835746, 5134.0758663440565, 5146.356705411824, 5182.870428239325, 5460.34475862895, 5481.725913704299, 5484.506394424481, 5504.614676972614, 5568.610197286192, 5750.45370689788, 5891.734871930774, 5911.0, 5915.497182739472, 5925.851853703649, 5891.293044834604, 5925.170476133345, 5940.732667029994, 5974.312954010301, 5993.0710739835395, 5585.972070139624, 5586.664800111966, 5587.245721827582, 5589.301337332833, 5601.831945041656, 5820.039693450618, 5959.731812068468, 6095.085737139376, 6101.84745381369, 6106.72519736604, 5692.203091567184, 5767.077267637158, 5773.364929857712, 5786.623869448473, 5827.067669172997, 5967.283925928917, 6004.699765011732, 6019.729112189962, 6022.217111775529, 6030.396960303934, 5672.347680016851, 5771.163181338682, 5774.971125144348, 5880.117982302689, 5892.175095486636, 5887.146363777314, 5893.793717219876, 5893.941060589425, 5906.616069955439, 5916.645001299936, 4565.018521017997, 4569.680122391467, 4573.679842411066, 4582.1293954148605, 4616.907661846744, 4025.4163146343617, 4079.714419990572, 4113.835446582163, 4164.604362585549, 4173.9582604174175, 5583.832485025456, 5588.776448941997, 5609.074502707089, 5628.04323265046, 5635.380108188096, 6003.249593800775, 6012.579119461683, 6027.095935609606, 6028.125921741411, 6046.969765151146, 5386.838394848082, 5504.532114770209, 5583.078791999355, 5646.520045796071, 5712.885742285131, 5291.788328466818, 5294.179402192666, 5298.28473156119, 5303.496167864047, 5305.495977882095, 5930.229070220844, 6184.5980011299125, 6220.160278362454, 6223.719932602953, 6229.937700623026, 5857.179994800646, 5893.322267939242, 5927.881442371215, 5929.140274660236, 5984.760609575568, 6157.722902469489, 6161.291451483136, 6175.073738939195, 6178.0, 6187.876242475035, 5731.283589551306, 5861.413858614104, 5908.793192238251, 5917.852053698692, 5927.081302398135, 5735.254416925773, 5855.473007429181, 5920.8815823684145, 5924.763009479572, 5973.790917317873, 5844.12338149264, 5851.034579294369, 5856.0, 5860.238169037998, 5867.119932010232, 5611.494965453129, 5684.77260909559, 5723.627964182481, 5858.062709966385, 5863.0, 5592.664440133605, 5710.714464276686, 5715.742791574472, 5737.08206686928, 5743.59794814359, 5842.649441033552, 5843.795467158629, 5854.648721076749, 5855.092460668603, 5865.853353666193, 5443.510084092451, 5627.465390787868, 5678.432156784289, 5739.225204597493, 5800.24596802413], "mootools.html": [1455.3378212913126, 1744.904030278335, 1777.6533575952687, 1786.919588618512, 1817.9454616361506, 7103.431725461951, 7259.056322678044, 7988.241117093874, 8299.087100418956, 8307.293880020197, 7680.193579674137, 7833.295003449688, 7961.880571791413, 7976.840463190732, 7976.840463190732, 2229.2754854672257, 2256.2103263857603, 2264.2527965771337, 2265.909363625453, 2266.6260067088992, 2248.4940888300166, 2261.366817291161, 2316.096722278313, 2316.5714342846545, 2321.791038806507, 2241.1483636218295, 2248.5615305015526, 2252.4706693926914, 2265.66015097735, 2275.8975846086964, 2250.4823890505113, 2273.318004598622, 2297.7242730872317, 2297.7587353327913, 2302.82728795341, 2295.735990361113, 2324.6861673674007, 2325.2442956039354, 2326.26722582386, 2333.801626861719, 7531.623418829036, 7588.772336829904, 7606.429517786189, 7609.048868891388, 7628.504147230467, 4796.448408433005, 4865.9756701216265, 4867.780949857265, 4869.391326084239, 4877.707337559757, 2968.3766409054124, 2975.5239161734235, 3064.8161110333454, 3074.200707815962, 3077.2460747117098, 842.5913431985482, 850.3664769746516, 852.4033176776281, 901.7970956534792, 910.426431348253, 10868.61959831402, 10869.347839129678, 10871.075958543533, 10888.61889833852, 10892.237543371966, 4429.224885645, 4469.150861336336, 4481.887952801206, 4484.506704262529, 4520.50274469808, 9426.340156189139, 9429.528523573794, 9484.762880928032, 9503.334766566411, 9526.809463810685, 5054.82308119214, 5066.518680725325, 5073.797048118034, 5078.162103252996, 5086.364204474441, 4032.1129351542613, 4120.114175452292, 4413.602775750198, 4584.541545845455, 4587.632989360844, 3701.2227432239533, 3739.3269211542183, 3752.6622603965775, 3752.849886004584, 3769.3026790043928, 1232.617888454582, 1244.545740804618, 1245.2404033539533, 1250.456051617531, 1252.6993521554944, 1303.5307289375817, 1304.341307639636, 1308.5158491358259, 1326.2771789374815, 1352.6550729563899, 7624.847503049908, 7657.540547567164, 7690.846183076307, 7736.7292144774665, 7796.454248202572, 449.5886264068406, 454.5749076644677, 457.2889157360337, 458.4178093820829, 465.75315083006063, 5960.254968128984, 5974.0, 5983.850403739854, 6000.789972350947, 6003.279606447254, 9285.164335209729, 9615.663451779154, 9621.759456013655, 9696.6121355145, 9699.321047526606, 9451.810963780687, 9550.426974381558, 9564.856527152098, 9584.137427631547, 9585.137337639506, 7386.2613738625705, 7512.924870751332, 7563.394928405714, 7585.544867308089, 7589.0, 7221.386182174364, 7305.817354566178, 7336.229695882069, 7350.044494215717, 7379.409647228102, 8450.577471126297, 8535.231829135408, 8561.61472733716, 8624.913750862412, 8666.523341216294, 8602.0, 8758.518281494578, 8778.956105219433, 8836.558172091241, 8867.423617464845, 6918.446524277945, 7181.605011724197, 7213.855722885618, 7216.170140433707, 7236.89144662841, 7675.923240767745, 7761.650725717243, 7770.650320735694, 7773.883391749241, 7794.025746781653, 7127.10911136108, 7271.3455788979245, 7276.927230727837, 7359.632018399166, 7383.741569045058, 7080.0, 7110.5022648414115, 7111.0756399768225, 7115.181754098345, 7222.494425390172, 7232.240614735377, 7267.927320726725, 7280.890786638311, 7327.706891724484, 7333.853322933618, 6492.383223593751, 6536.673166341759, 6539.509536784665, 6544.6727663617585, 6556.704948277244, 6479.935200647933, 6696.263411024881, 6710.188249172794, 6710.731570737116, 6733.326667333227], "ext.html": [547.4435419503262, 578.6759414727755, 578.9855253618659, 581.8138195777352, 590.4508806809667, 38426.61573384266, 39635.20729585407, 39695.206095878064, 39721.2055758885, 39762.204755904866, 42308.78845605768, 42938.14123717524, 42959.0, 43009.35485967713, 43020.139597208035, 9293.256539476859, 9431.43411395315, 9465.763355916088, 9479.289053320994, 9493.335466517347, 9179.541022948859, 9317.487538185396, 9318.20795232406, 9325.626974920995, 9327.300452466092, 9384.906150938506, 9455.858162127573, 9459.952700236523, 9464.479453630047, 9481.81036379272, 9227.123423274777, 9299.302552308603, 9320.114589114024, 9331.673391431268, 9335.76660583484, 9146.817063658757, 9272.026437224062, 9283.025282345392, 9284.07159284073, 9306.115918987685, 39275.214495710214, 39604.60395396038, 39663.60336396628, 39733.0, 39736.80131599352, 2828.6820776939426, 2871.3395918938554, 2977.211039074647, 3116.407882502317, 3255.9580934101095, 26866.731332686617, 27284.727152728417, 27613.0, 27809.721902780915, 28319.716802831914, 2351.5179388225374, 2385.0459816073535, 2421.5520128776056, 2444.010175878772, 2499.7500249975037, 256897.0, 257679.0, 257843.0, 259047.0, 259295.0, 56353.0, 56660.43339566634, 56704.0, 56713.43286567082, 56770.14844777332, 56783.43216567864, 57811.42188578145, 60860.0, 62168.78312168747, 62219.37780622136, 16244.187790610422, 16331.591710207102, 16456.67086658284, 16458.259378328003, 16467.670646587, 12443.25340479556, 12522.37388130608, 12526.498940042296, 12527.248365097941, 12531.18547294423, 18858.811411885705, 19154.808451915582, 19200.13599388031, 19216.327428539935, 19233.134508947132, 8768.517731524827, 8997.505137217386, 8999.19007289334, 9003.684871029482, 9011.459312441275, 981.6183248708132, 1039.5166247694858, 1082.7061661314654, 1084.9620263290747, 1090.5038207615517, 28090.29774255619, 28432.28919276993, 28742.425151496853, 29149.708502915124, 29319.706802931698, 980.1472718734603, 1016.8678071850612, 1019.4393083803878, 1031.231732359382, 1089.9128069754402, 13820.723585528232, 15223.162726050174, 15419.0, 15447.5365739028, 15595.220238988006, 297652.0, 299925.0, 301064.0, 301798.0, 302644.0, 54220.45779542233, 54311.0, 54431.0, 54489.1826622601, 54512.0, 1377.1186440677975, 1400.7548678981138, 1421.4385317799617, 1421.7156568686305, 1422.907511011781, 28814.423711526073, 29084.854575726986, 29142.27144321409, 29394.70605294005, 29397.706022939496, 45715.31427028664, 46073.76963115163, 46076.0, 46079.0, 46079.76960115178, 267103.0, 269006.0, 269259.0, 269738.0, 270224.0, 30501.847490762404, 31275.374492510477, 31366.686333136375, 31436.842815785774, 31514.0, 37261.441078384385, 38023.809880950415, 38042.42936356012, 38456.0, 38478.23043539058, 32106.0, 32610.803947249948, 32968.670313297516, 33210.0, 33418.66581334253, 32435.18912027218, 32452.35095298128, 34169.0, 34927.47608785921, 35182.120446988, 34942.65057349394, 35392.949362885236, 35508.644913551565, 35695.82152089223, 35713.28573428569, 29712.257193570334, 31391.37217255688, 31560.842195788875, 31610.36779264448, 31630.525542116426, 23862.16482423107, 24105.397365066012, 24547.63178552359, 24556.140535081187, 24624.753752462246], "prototype.html": [305.3343710710651, 309.2454411236584, 309.39358856640996, 321.50969771099074, 328.2302999466252, 6162.044883043124, 6188.690565471726, 6219.533534984872, 6292.528060395466, 6299.77950771723, 6076.453119219269, 6125.877482450348, 6129.417705317999, 6153.8769124652035, 6193.752249909998, 4799.208130658446, 4833.32333473314, 4833.564979151875, 4835.661503694742, 4840.757962101899, 4815.831445899395, 4820.156472617296, 4821.083994041139, 4831.565159135677, 4835.0, 4644.883877903046, 4745.833895813647, 4785.1147537705465, 4888.0, 4891.730954797485, 4860.951390486085, 4870.683405578626, 4880.829170978998, 4881.511848815126, 4884.998575292075, 4199.328107502815, 4200.621944025022, 4214.304639734441, 4217.34631132175, 4229.196452674013, 6110.969445152746, 6115.87768244637, 6119.785807496761, 6134.938650613526, 6160.383961603804, 5239.266502689588, 5403.918941215885, 5410.83767486976, 5424.430434804328, 5433.809816656398, 6535.411812936859, 6571.34286571339, 6575.506836987197, 6586.04502347157, 6592.373724496165, 4492.820287188509, 4495.011097558532, 4495.393121928563, 4501.077279157765, 4502.347159661864, 6649.501287403464, 6835.316468353125, 6854.177498700188, 6861.142357205349, 6875.759348422781, 4587.174308624413, 4590.288505281686, 4596.5863072323655, 4596.954030459719, 4598.356230127785, 4695.107929493385, 4696.577308042292, 4702.412198475191, 4707.152712511713, 4720.622350211975, 5381.892362152813, 5399.83800485986, 5408.4050754416985, 5417.187421886749, 5417.864553386197, 6383.553151279459, 6573.3426657333885, 6575.769848055295, 6583.3416658334745, 6593.307702691244, 1584.5404832598647, 1625.3742309210802, 1630.5678995066316, 1632.9918350408173, 1651.3229575873834, 999.6351331763854, 1000.3397757480028, 1003.3478239144614, 1007.2495990487134, 1014.1481155828991, 6204.534659900525, 6212.751489940442, 6225.8132256032395, 6227.96886015567, 6232.657203853741, 6766.424853887376, 6767.424768894601, 6773.356531129535, 6792.184937807495, 6793.184817821893, 6066.696665166724, 6193.4425901669065, 6208.255009398901, 6224.9377506224355, 6227.564070515111, 3740.3828368318923, 3751.5498140222803, 3754.1553150541454, 3756.1360886996144, 3762.097096696773, 6962.686679099453, 6963.7562685305775, 6966.9651651741415, 6974.895376569356, 6982.895256571155, 6728.529002969745, 6890.276520965327, 6915.757948471779, 6916.412104971134, 6958.721651133999, 6954.965225173842, 6966.79099627012, 6973.965130174317, 6977.406920411822, 6985.196702379189, 6746.0555522227905, 6749.055132281386, 6762.52662313653, 6762.695678694372, 6776.728930842908, 6536.4117229447675, 6623.437007854386, 6626.701798418986, 6643.468522518284, 6644.90032649501, 6961.825954351182, 6984.4063254623925, 6989.615571143636, 7006.404455621329, 7043.7534686285735, 4390.4511936008, 4415.492218394926, 4422.137683151883, 4430.202563538594, 4446.5108838027145, 6722.731090756511, 6755.527113102035, 6762.560433571802, 6763.830904227434, 6771.593704377753, 6516.380943810331, 6546.705398257185, 6549.279579246184, 6570.342965703391, 6577.6053436792035, 6555.475561955128, 6567.343265673586, 6570.638614876037, 6580.539362244788, 6589.703463344257, 6307.716152773228, 6367.0, 6371.840703982438, 6417.903731444126, 6420.101185834081, 6521.250056243403, 6531.314212007861, 6540.117084193573, 6540.8364790880605, 6571.145751052332, 6380.585261957958, 6383.712732926937, 6397.0404439332615, 6398.360163983751, 6405.487560995202], "yui.html": [662.8177251255908, 712.7826013066019, 756.1040167401629, 778.2839787395594, 781.4529829119616, 13836.654083647902, 13958.930205348985, 14071.718565628682, 14081.929590352047, 14095.647608809784, 13170.209787412738, 13250.46998120074, 13333.666658333546, 13364.198148111096, 13749.106308089968, 894.0478390514098, 911.1844898815556, 911.8632205169212, 911.9772005699845, 912.393258483108, 894.110360191607, 900.3877363392891, 900.6847603338812, 901.1079031758545, 901.5402144906079, 939.8543225800012, 949.5347279832902, 950.2208189284789, 950.6435086842434, 951.4481600671594, 946.4510583861344, 947.924166066713, 947.9430435064922, 948.2508818033814, 948.2793077261297, 698.8567343694581, 700.1283402164287, 700.9018737376771, 701.0885848397114, 701.5790525684599, 11557.0, 11648.359340236284, 11660.300381977024, 11673.883261167364, 11688.766224675544, 10401.0, 10425.843612345745, 10670.73323166927, 10812.621558245424, 11039.337639741561, 9086.586090746965, 9112.271018318519, 9130.634774609074, 9244.121808428188, 9375.015623359517, 3256.6743325667244, 3364.2598628301735, 3392.2028323343993, 3394.13449570358, 3514.1917359007316, 41989.37015944763, 42594.0, 42739.35890961607, 42929.14141717179, 48299.0, 5976.073708575178, 6072.089186622042, 6111.449969502677, 6161.106639537242, 6343.904841427382, 9968.950155249177, 9969.80060398788, 9985.101340879355, 9985.151262142654, 9992.200623950066, 6238.937610623836, 6289.55973081889, 6444.033394990789, 6449.709763060673, 6570.638614876228, 3803.5625903021505, 3835.4246862970776, 3875.050612599931, 3878.204967981557, 3926.4306675532457, 2798.734120258572, 2819.5488721804413, 2824.675162356314, 2826.1804076817903, 2826.2792987787984, 410.16940695092677, 410.81102692761067, 412.7853516171574, 414.8071146916638, 415.1613740244689, 467.4460763994677, 550.8898220355865, 551.5064017704133, 602.3554796367845, 634.7936920500763, 8216.34269258458, 8317.500949942902, 8412.411131220755, 8428.30612356669, 8561.700340488052, 553.1591980190088, 553.9533706275695, 566.2214455124205, 569.9401562835925, 578.4302462074853, 3419.7093247074276, 3694.8152592370275, 3702.5556933167654, 3751.3247615429486, 4010.2781499329817, 58654.706726466946, 59195.0, 59434.70282648559, 59513.10730339048, 59527.40472595305, 51601.48398516042, 51788.223176652384, 51955.48044519506, 53041.469585304425, 53108.20337694938, 43450.34824477635, 44931.32603010957, 46691.766541167075, 47906.5209347916, 48541.75729121332, 7548.584827834522, 7549.245075492407, 7890.881636775338, 7989.360851131779, 8102.270795628186, 33441.83279083687, 33499.0, 34076.82961585176, 34481.65518344885, 34515.654843451244, 42677.57322426736, 44553.331700023875, 44934.0, 45043.0, 45353.546464534935, 7193.964030179815, 7394.55632662042, 7492.850142997218, 7599.240075992357, 7601.661067007672, 10897.509612067635, 10901.0, 10938.671839844817, 11343.376114313793, 11749.177557571229, 10075.34510256831, 10722.785544289227, 10752.784944301227, 10848.294860834021, 10851.283271847506, 9329.58016889228, 9658.227341812779, 9773.951130244302, 10041.246906482189, 10047.648332308334, 10314.27800053989, 10662.253642244968, 10790.244682872437, 10920.890791092304, 11093.500792464198, 8903.0, 9008.819823603622, 9254.768630784285, 9284.442933424016, 9366.391184572982, 8533.573321334032, 9124.908750912406, 9344.906550934404, 9355.53222338894, 9446.102620251066]}, "summary": {"lowerIsBetter": false, "suite": 6624.817583016348, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6648.235811372302, "unit": "ms", "value": 6648.235811372302}, "dojo.html": {"lowerIsBetter": false, "filtered": 5467.419446479036, "unit": "ms", "value": 5467.419446479036}, "mootools.html": {"lowerIsBetter": false, "filtered": 4485.259658980366, "unit": "ms", "value": 4485.259658980366}, "ext.html": {"lowerIsBetter": false, "filtered": 18216.066507839685, "unit": "ms", "value": 18216.066507839685}, "prototype.html": {"lowerIsBetter": false, "filtered": 4918.610204883304, "unit": "ms", "value": 4918.610204883304}, "yui.html": {"lowerIsBetter": false, "filtered": 5786.749845125849, "unit": "ms", "value": 5786.749845125849}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0047.e"}, "testrun": {"date": 1447293713, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111155147", "branch": "Fx-Team", "revision": "dd627c83397a2be0216a881e6a58e5f5f5675cdd"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 166.0, 167.0, 167.0, 167.0, 168.0, 169.0, 171.0, 169.0, 169.0], "ai-astar": [110.0, 100.0, 110.0, 109.0, 108.0, 118.0, 108.0, 108.0, 111.0, 110.0], "imaging-gaussian-blur": [121.0, 116.0, 121.0, 116.0, 121.0, 115.0, 121.0, 116.0, 121.0, 121.0], "audio-beat-detection": [154.0, 128.0, 152.0, 160.0, 128.0, 147.0, 151.0, 128.0, 163.0, 129.0], "json-stringify-tinderbox": [69.0, 70.0, 68.0, 67.0, 69.0, 69.0, 68.0, 68.0, 70.0, 74.0], "stanford-crypto-pbkdf2": [145.0, 155.0, 157.0, 154.0, 157.0, 157.0, 159.0, 155.0, 145.0, 142.0], "json-parse-financial": [63.0, 66.0, 64.0, 63.0, 65.0, 64.0, 65.0, 71.0, 63.0, 64.0], "stanford-crypto-sha256-iterative": [72.0, 71.0, 71.0, 73.0, 73.0, 73.0, 70.0, 73.0, 76.0, 75.0], "audio-fft": [74.0, 71.0, 77.0, 67.0, 72.0, 71.0, 72.0, 125.0, 64.0, 68.0], "imaging-darkroom": [127.0, 126.0, 126.0, 127.0, 127.0, 126.0, 127.0, 126.0, 126.0, 127.0], "stanford-crypto-ccm": [128.0, 125.0, 131.0, 136.0, 129.0, 126.0, 130.0, 135.0, 132.0, 135.0], "audio-oscillator": [89.0, 89.0, 128.0, 86.0, 89.0, 88.0, 126.0, 88.0, 89.0, 130.0], "stanford-crypto-aes": [89.0, 87.0, 87.0, 88.0, 87.0, 86.0, 87.0, 87.0, 86.0, 88.0], "imaging-desaturate": [104.0, 106.0, 104.0, 106.0, 110.0, 104.0, 105.0, 106.0, 104.0, 104.0]}, "summary": {"lowerIsBetter": true, "suite": 1525.1, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 76.1, "unit": "ms", "value": 76.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 152.6, "unit": "ms", "value": 152.6}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.0, "unit": "ms", "value": 144.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 130.7, "unit": "ms", "value": 130.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 126.5, "unit": "ms", "value": 126.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 64.8, "unit": "ms", "value": 64.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 100.2, "unit": "ms", "value": 100.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 109.2, "unit": "ms", "value": 109.2}, "audio-dft": {"lowerIsBetter": true, "filtered": 167.7, "unit": "ms", "value": 167.7}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 72.7, "unit": "ms", "value": 72.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 69.2, "unit": "ms", "value": 69.2}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 118.9, "unit": "ms", "value": 118.9}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.2, "unit": "ms", "value": 87.2}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 105.3, "unit": "ms", "value": 105.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0047.e"}, "testrun": {"date": 1447293713, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111155147", "branch": "Fx-Team", "revision": "dd627c83397a2be0216a881e6a58e5f5f5675cdd"}}, {"talos_counters": {}, "results": {"DeltaBlue": [196.8503937007874], "Encrypt": [325.8390355164549], "NavierStokes": [5809.248554913294], "Decrypt": [5786.127167630058], "Splay": [753.0120481927711], "Richards": [166.38935108153078], "RegExp": [28083.333333333332], "Earley": [793.6507936507936], "Boyer": [12871.794871794871], "RayTrace": [1126.126126126126]}, "summary": {"lowerIsBetter": false, "suite": 19299.88963182778, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 335.87944, "unit": "score", "value": 335.87944}, "Encrypt": {"lowerIsBetter": false, "filtered": 816.9094890000002, "unit": "score", "value": 816.9094890000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 255.4547263681593, "unit": "score", "value": 255.4547263681593}, "Decrypt": {"lowerIsBetter": false, "filtered": 46.003309690309706, "unit": "score", "value": 46.003309690309706}, "Splay": {"lowerIsBetter": false, "filtered": 108.22004799999995, "unit": "score", "value": 108.22004799999995}, "RegExp": {"lowerIsBetter": false, "filtered": 32.43863501483677, "unit": "score", "value": 32.43863501483677}, "Richards": {"lowerIsBetter": false, "filtered": 212.16501999999997, "unit": "score", "value": 212.16501999999997}, "Earley": {"lowerIsBetter": false, "filtered": 839.7433799999998, "unit": "score", "value": 839.7433799999998}, "Boyer": {"lowerIsBetter": false, "filtered": 51.77700597609562, "unit": "score", "value": 51.77700597609562}, "RayTrace": {"lowerIsBetter": false, "filtered": 657.110232, "unit": "score", "value": 657.110232}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0047.e"}, "testrun": {"date": 1447293713, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151111155147", "branch": "Fx-Team", "revision": "dd627c83397a2be0216a881e6a58e5f5f5675cdd"}}] 18:22:01 INFO - RETURN: dromaeo_css: 6624.82 18:22:01 INFO - RETURN: kraken: 1525.10 18:22:01 INFO - RETURN: v8_7: 19299.89 18:22:01 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "19299.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1525.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "6624.82"}}} 18:22:01 INFO - Return code: 0 18:22:01 INFO - # TBPL SUCCESS # 18:22:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:22:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:22:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:22:01 INFO - 2015-11-11 18:22:01.728 screenresolution[1657:10628] starting screenresolution argv=screenresolution get 18:22:01 INFO - 2015-11-11 18:22:01.733 screenresolution[1657:10628] Display 0: 1600x1200x32@60 18:22:01 INFO - 2015-11-11 18:22:01.739 screenresolution[1658:10631] starting screenresolution argv=screenresolution list 18:22:01 INFO - Available Modes on Display 0 18:22:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:22:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:22:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:22:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:22:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:22:01 INFO - Intel HD Graphics 3000: 18:22:01 INFO - Chipset Model: Intel HD Graphics 3000 18:22:01 INFO - Type: GPU 18:22:01 INFO - Bus: Built-In 18:22:01 INFO - VRAM (Total): 512 MB 18:22:01 INFO - VRAM (Dynamic, Max): 10 18:22:01 INFO - Vendor: Intel (0x8086) 18:22:01 INFO - Device ID: 0x0116 18:22:01 INFO - Revision ID: 0x0009 18:22:01 INFO - Displays: 18:22:01 INFO - Display: 18:22:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:22:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:22:01 INFO - Display Serial Number: 1600x1200 60 18:22:01 INFO - Main Display: Yes 18:22:01 INFO - Mirror: Off 18:22:01 INFO - Online: Yes 18:22:01 INFO - Rotation: Supported 18:22:01 INFO - Return code: 0 18:22:01 INFO - Running post-action listener: _resource_record_post_action 18:22:01 INFO - Running post-run listener: _resource_record_post_run 18:22:03 INFO - Total resource usage - Wall time: 1247s; CPU: 30.0%; Read bytes: 41964544; Write bytes: 689200128; Read time: 5850; Write time: 86719 18:22:03 INFO - install - Wall time: 37s; CPU: 30.0%; Read bytes: 339059200; Write bytes: 333834240; Read time: 32794; Write time: 4262 18:22:03 INFO - run-tests - Wall time: 1210s; CPU: 30.0%; Read bytes: 39752704; Write bytes: 344077312; Read time: 5140; Write time: 81389 18:22:03 INFO - Running post-run listener: _upload_blobber_files 18:22:03 INFO - Blob upload gear active. 18:22:03 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:22:03 INFO - Copying logs to upload dir... 18:22:03 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1302.968894 ========= master_lag: 1.92 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 44 secs) (at 2015-11-11 18:22:05.007457) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:22:05.013076) ========= 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.EivGNJWvi7/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.EXF814vlsp/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010011 build_url: 'https://queue.taskcluster.net/v1/task/MiVpYtrrR7mkE_N0HJQceQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.06 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:22:05.082534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:22:05.082932) ========= 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.EivGNJWvi7/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.EXF814vlsp/Listeners TMPDIR=/var/folders/fg/qn66yljs4p5gmy5z_vgrth4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005330 ========= master_lag: 0.72 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:22:05.811065) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 18:22:05.811539) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 18:22:05.818040) ========= ========= Total master_lag: 4.76 =========