builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0018 starttime: 1447833873.81 results: success (0) buildid: 20151117223936 builduid: 762ea5c4c6e74f42ba9b0019f66605d3 revision: c699b2c839a9f8c2b964dd956de9084d3b93a13f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:33.813454) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:33.814431) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:33.814830) ========= 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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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.005967 basedir: '/builds/slave/test' ========= master_lag: 0.35 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.172658) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.172964) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.211040) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.211430) ========= 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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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.010893 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.260346) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.260675) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.261089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.261382) ========= 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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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-18 00:04:34-- 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.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% 1.26G=0s 2015-11-18 00:04:34 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.237286 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.514763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.515084) ========= 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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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.092416 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.622281) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:34.622723) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c699b2c839a9f8c2b964dd956de9084d3b93a13f --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 c699b2c839a9f8c2b964dd956de9084d3b93a13f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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-18 00:04:34,712 truncating revision to first 12 chars 2015-11-18 00:04:34,712 Setting DEBUG logging. 2015-11-18 00:04:34,712 attempt 1/10 2015-11-18 00:04:34,712 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c699b2c839a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-18 00:04:34,953 unpacking tar archive at: fx-team-c699b2c839a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.497552 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:35.136953) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:35.137264) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:35.158675) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:35.158962) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-18 00:04:35.159416) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2015-11-18 00:04:35.159701) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 00:04:35 INFO - MultiFileLogger online at 20151118 00:04:35 in /builds/slave/test 00:04:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:04:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:04:35 INFO - {'append_to_log': False, 00:04:35 INFO - 'base_work_dir': '/builds/slave/test', 00:04:35 INFO - 'blob_upload_branch': 'Fx-Team', 00:04:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:04:35 INFO - 'branch': 'Fx-Team', 00:04:35 INFO - 'buildbot_json_path': 'buildprops.json', 00:04:35 INFO - 'config_files': ('talos/mac_config.py',), 00:04:35 INFO - 'default_actions': ('clobber', 00:04:35 INFO - 'read-buildbot-config', 00:04:35 INFO - 'download-and-extract', 00:04:35 INFO - 'populate-webroot', 00:04:35 INFO - 'create-virtualenv', 00:04:35 INFO - 'install', 00:04:35 INFO - 'run-tests'), 00:04:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:04:35 INFO - 'download_minidump_stackwalk': True, 00:04:35 INFO - 'download_symbols': 'ondemand', 00:04:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:04:35 INFO - 'tooltool.py': '/tools/tooltool.py', 00:04:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:04:35 INFO - '/tools/misc-python/virtualenv.py')}, 00:04:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:04:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:04:35 INFO - 'installer_path': 'installer.exe', 00:04:35 INFO - 'log_level': 'info', 00:04:35 INFO - 'log_name': 'talos', 00:04:35 INFO - 'log_to_console': True, 00:04:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:04:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:04:35 INFO - 'opt_config_files': (), 00:04:35 INFO - 'pip_index': False, 00:04:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:04:35 INFO - 'cmd': ('bash', 00:04:35 INFO - '-c', 00:04:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:04:35 INFO - 'enabled': True, 00:04:35 INFO - 'halt_on_failure': False, 00:04:35 INFO - 'name': 'check_screen_resolution'},), 00:04:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:04:35 INFO - 'cmd': ('bash', 00:04:35 INFO - '-c', 00:04:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:04:35 INFO - 'enabled': True, 00:04:35 INFO - 'halt_on_failure': False, 00:04:35 INFO - 'name': 'check_screen_resolution'},), 00:04:35 INFO - 'run_cmd_checks_enabled': True, 00:04:35 INFO - 'sps_profile': False, 00:04:35 INFO - 'sps_profile_interval': 0, 00:04:35 INFO - 'suite': 'dromaeojs', 00:04:35 INFO - 'system_bits': '64', 00:04:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:04:35 INFO - 'title': 't-yosemite-r5-0018', 00:04:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:04:35 INFO - 'use_talos_json': True, 00:04:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:04:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:04:35 INFO - 'work_dir': 'build'} 00:04:35 INFO - ##### 00:04:35 INFO - ##### Running clobber step. 00:04:35 INFO - ##### 00:04:35 INFO - Running pre-action listener: _resource_record_pre_action 00:04:35 INFO - Running main action method: clobber 00:04:35 INFO - rmtree: /builds/slave/test/build 00:04:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:04:39 INFO - Running post-action listener: _resource_record_post_action 00:04:39 INFO - ##### 00:04:39 INFO - ##### Running read-buildbot-config step. 00:04:39 INFO - ##### 00:04:39 INFO - Running pre-action listener: _resource_record_pre_action 00:04:39 INFO - Running main action method: read_buildbot_config 00:04:39 INFO - Using buildbot properties: 00:04:39 INFO - { 00:04:39 INFO - "properties": { 00:04:39 INFO - "buildnumber": 1252, 00:04:39 INFO - "product": "firefox", 00:04:39 INFO - "script_repo_revision": "production", 00:04:39 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 00:04:39 INFO - "repository": "", 00:04:39 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 00:04:39 INFO - "buildid": "20151117223936", 00:04:39 INFO - "slavename": "t-yosemite-r5-0018", 00:04:39 INFO - "pgo_build": "False", 00:04:39 INFO - "basedir": "/builds/slave/test", 00:04:39 INFO - "project": "", 00:04:39 INFO - "platform": "yosemite", 00:04:39 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 00:04:39 INFO - "slavebuilddir": "test", 00:04:39 INFO - "scheduler": "tests-fx-team-macosx64-talos", 00:04:39 INFO - "branch": "fx-team", 00:04:39 INFO - "repo_path": "integration/fx-team", 00:04:39 INFO - "stage_platform": "macosx64", 00:04:39 INFO - "builduid": "762ea5c4c6e74f42ba9b0019f66605d3", 00:04:39 INFO - "revision": "c699b2c839a9f8c2b964dd956de9084d3b93a13f" 00:04:39 INFO - }, 00:04:39 INFO - "sourcestamp": { 00:04:39 INFO - "repository": "", 00:04:39 INFO - "hasPatch": false, 00:04:39 INFO - "project": "", 00:04:39 INFO - "branch": "fx-team-macosx64-talos", 00:04:39 INFO - "changes": [ 00:04:39 INFO - { 00:04:39 INFO - "category": null, 00:04:39 INFO - "files": [ 00:04:39 INFO - { 00:04:39 INFO - "url": null, 00:04:39 INFO - "name": "https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 00:04:39 INFO - } 00:04:39 INFO - ], 00:04:39 INFO - "repository": "", 00:04:39 INFO - "rev": "c699b2c839a9f8c2b964dd956de9084d3b93a13f", 00:04:39 INFO - "who": "philringnalda@gmail.com", 00:04:39 INFO - "when": 1447833861, 00:04:39 INFO - "number": 6676322, 00:04:39 INFO - "comments": "Back out 6fa3b2df62cc (bug 1218443) for browser_ext_pageAction_context.js leaks\nCLOSED TREE", 00:04:39 INFO - "project": "", 00:04:39 INFO - "at": "Wed 18 Nov 2015 00:04:21", 00:04:39 INFO - "branch": "fx-team-macosx64-talos", 00:04:39 INFO - "revlink": "", 00:04:39 INFO - "properties": [ 00:04:39 INFO - [ 00:04:39 INFO - "buildid", 00:04:39 INFO - "20151117223936", 00:04:39 INFO - "Change" 00:04:39 INFO - ], 00:04:39 INFO - [ 00:04:39 INFO - "builduid", 00:04:39 INFO - "762ea5c4c6e74f42ba9b0019f66605d3", 00:04:39 INFO - "Change" 00:04:39 INFO - ], 00:04:39 INFO - [ 00:04:39 INFO - "pgo_build", 00:04:39 INFO - "False", 00:04:39 INFO - "Change" 00:04:39 INFO - ] 00:04:39 INFO - ], 00:04:39 INFO - "revision": "c699b2c839a9f8c2b964dd956de9084d3b93a13f" 00:04:39 INFO - } 00:04:39 INFO - ], 00:04:39 INFO - "revision": "c699b2c839a9f8c2b964dd956de9084d3b93a13f" 00:04:39 INFO - } 00:04:39 INFO - } 00:04:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 00:04:39 INFO - Running post-action listener: _resource_record_post_action 00:04:39 INFO - ##### 00:04:39 INFO - ##### Running download-and-extract step. 00:04:39 INFO - ##### 00:04:39 INFO - Running pre-action listener: _resource_record_pre_action 00:04:39 INFO - Running main action method: download_and_extract 00:04:39 INFO - mkdir: /builds/slave/test/build/tests 00:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:39 INFO - https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:04:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/test_packages.json 00:04:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/test_packages.json 00:04:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:04:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:04:39 INFO - Downloaded 1149 bytes. 00:04:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:04:39 INFO - Using the following test package requirements: 00:04:39 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 00:04:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 00:04:39 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 00:04:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 00:04:39 INFO - u'jsshell-mac.zip'], 00:04:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 00:04:39 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 00:04:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 00:04:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 00:04:39 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 00:04:39 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 00:04:39 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 00:04:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 00:04:39 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 00:04:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 00:04:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 00:04:39 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 00:04:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:39 INFO - https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:04:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 00:04:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 00:04:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/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 00:04:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/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 00:04:40 INFO - Downloaded 17463513 bytes. 00:04:40 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 00:04:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 00:04:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 00:04:46 INFO - Return code: 0 00:04:46 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 00:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:46 INFO - https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:04:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 00:04:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 00:04:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/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 00:04:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/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 00:04:54 INFO - Downloaded 17463513 bytes. 00:04:54 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 00:04:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 00:04:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 00:05:00 INFO - Return code: 0 00:05:00 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')]} 00:05:00 INFO - https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 00:05:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 00:05:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 00:05:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/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 00:05:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/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 00:05:02 INFO - Downloaded 11131693 bytes. 00:05:02 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 00:05:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 00:05:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 00:05:02 INFO - Return code: 0 00:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:02 INFO - https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 00:05:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 00:05:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 00:05:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 00:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/mND7yt19TQeJQ4ZSlYQDNA/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 00:05:06 INFO - Downloaded 108846449 bytes. 00:05:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 00:05:06 INFO - mkdir: /builds/slave/test/properties 00:05:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:05:06 INFO - Writing to file /builds/slave/test/properties/build_url 00:05:06 INFO - Contents: 00:05:06 INFO - build_url:https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 00:05:06 INFO - Running post-action listener: _resource_record_post_action 00:05:06 INFO - Running post-action listener: set_extra_try_arguments 00:05:06 INFO - ##### 00:05:06 INFO - ##### Running populate-webroot step. 00:05:06 INFO - ##### 00:05:06 INFO - Running pre-action listener: _resource_record_pre_action 00:05:06 INFO - Running main action method: populate_webroot 00:05:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:05:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:05:06 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:05:06 INFO - '../fennec_ids.txt'], 00:05:06 INFO - 'tests': ['tcheck2']}, 00:05:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:05:06 INFO - '--tppagecycles', 00:05:06 INFO - '7'], 00:05:06 INFO - 'tests': ['tsvgm']}}, 00:05:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:05:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:05:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:05:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:05:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:05:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:05:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:05:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:06 INFO - 'talos_options': ['--e10s'], 00:05:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:05:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:06 INFO - 'tests': ['damp', 'tps']}, 00:05:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:06 INFO - 'talos_options': ['--e10s'], 00:05:06 INFO - 'tests': ['damp', 'tps']}, 00:05:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:05:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:05:06 INFO - 'other': {'tests': ['a11yr', 00:05:06 INFO - 'ts_paint', 00:05:06 INFO - 'tpaint', 00:05:06 INFO - 'sessionrestore', 00:05:06 INFO - 'sessionrestore_no_auto_restore']}, 00:05:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:05:06 INFO - 'tests': ['a11yr', 00:05:06 INFO - 'ts_paint', 00:05:06 INFO - 'tpaint', 00:05:06 INFO - 'sessionrestore', 00:05:06 INFO - 'sessionrestore_no_auto_restore']}, 00:05:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:05:06 INFO - 'tests': ['a11yr', 00:05:06 INFO - 'ts_paint', 00:05:06 INFO - 'tpaint', 00:05:06 INFO - 'sessionrestore', 00:05:06 INFO - 'sessionrestore_no_auto_restore']}, 00:05:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:05:06 INFO - 'tests': ['a11yr', 00:05:06 INFO - 'ts_paint', 00:05:06 INFO - 'tpaint', 00:05:06 INFO - 'sessionrestore', 00:05:06 INFO - 'sessionrestore_no_auto_restore']}, 00:05:06 INFO - 'other_l64': {'tests': ['a11yr', 00:05:06 INFO - 'ts_paint', 00:05:06 INFO - 'tpaint', 00:05:06 INFO - 'sessionrestore', 00:05:06 INFO - 'sessionrestore_no_auto_restore']}, 00:05:06 INFO - 'other_nol64': {'tests': ['a11yr', 00:05:06 INFO - 'ts_paint', 00:05:06 INFO - 'tpaint', 00:05:06 INFO - 'sessionrestore', 00:05:06 INFO - 'sessionrestore_no_auto_restore']}, 00:05:06 INFO - 'svgr': {'tests': ['tsvgx', 00:05:06 INFO - 'tsvgr_opacity', 00:05:06 INFO - 'tart', 00:05:06 INFO - 'tscrollx', 00:05:06 INFO - 'cart']}, 00:05:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:05:06 INFO - 'tests': ['tsvgx', 00:05:06 INFO - 'tsvgr_opacity', 00:05:06 INFO - 'tart', 00:05:06 INFO - 'tscrollx', 00:05:06 INFO - 'cart']}, 00:05:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:06 INFO - 'tests': ['tp5o']}, 00:05:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:06 INFO - 'talos_options': ['--e10s'], 00:05:06 INFO - 'tests': ['tp5o']}, 00:05:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:06 INFO - 'talos_options': ['--xperf_path', 00:05:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:05:06 INFO - 'tests': ['tp5n']}, 00:05:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:05:06 INFO - 'talos_options': ['--e10s', 00:05:06 INFO - '--xperf_path', 00:05:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:05:06 INFO - 'tests': ['tp5n']}}, 00:05:06 INFO - 'talos.zip': {'path': '', 00:05:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:05:06 INFO - Running post-action listener: _resource_record_post_action 00:05:06 INFO - ##### 00:05:06 INFO - ##### Running create-virtualenv step. 00:05:06 INFO - ##### 00:05:06 INFO - Running pre-action listener: _resource_record_pre_action 00:05:06 INFO - Running main action method: create_virtualenv 00:05:06 INFO - Creating virtualenv /builds/slave/test/build/venv 00:05:06 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 00:05:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:05:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:05:07 INFO - Using real prefix '/tools/python27' 00:05:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:05:08 INFO - Installing distribute.............................................................................................................................................................................................done. 00:05:11 INFO - Installing pip.................done. 00:05:11 INFO - Return code: 0 00:05:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:11 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 0x10feaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde63f23090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd29f0>, '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 0x10fb32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdc68c8>, '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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 00:05:11 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 00:05:11 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 00:05:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZJgq0VvVTI/Render', 00:05:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:11 INFO - 'HOME': '/Users/cltbld', 00:05:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:11 INFO - 'LOGNAME': 'cltbld', 00:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:11 INFO - 'MOZ_NO_REMOTE': '1', 00:05:11 INFO - 'NO_EM_RESTART': '1', 00:05:11 INFO - 'PAGER': '/bin/cat', 00:05:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:11 INFO - 'PWD': '/builds/slave/test', 00:05:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:11 INFO - 'SHELL': '/bin/bash', 00:05:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDkqdjHCA2/Listeners', 00:05:11 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 00:05:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:11 INFO - 'USER': 'cltbld', 00:05:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:11 INFO - 'XPC_FLAGS': '0x0', 00:05:11 INFO - 'XPC_SERVICE_NAME': '0', 00:05:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:12 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 00:05:12 INFO - Cleaning up... 00:05:12 INFO - Return code: 0 00:05:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10feaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde63f23090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd29f0>, '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 0x10fb32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdc68c8>, '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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 00:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 00:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:05:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZJgq0VvVTI/Render', 00:05:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:12 INFO - 'HOME': '/Users/cltbld', 00:05:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:12 INFO - 'LOGNAME': 'cltbld', 00:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:12 INFO - 'MOZ_NO_REMOTE': '1', 00:05:12 INFO - 'NO_EM_RESTART': '1', 00:05:12 INFO - 'PAGER': '/bin/cat', 00:05:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:12 INFO - 'PWD': '/builds/slave/test', 00:05:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:12 INFO - 'SHELL': '/bin/bash', 00:05:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDkqdjHCA2/Listeners', 00:05:12 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 00:05:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:12 INFO - 'USER': 'cltbld', 00:05:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:12 INFO - 'XPC_FLAGS': '0x0', 00:05:12 INFO - 'XPC_SERVICE_NAME': '0', 00:05:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:12 INFO - Downloading/unpacking psutil>=0.7.1 00:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:05:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:05:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:15 INFO - Installing collected packages: psutil 00:05:15 INFO - Running setup.py install for psutil 00:05:15 INFO - building 'psutil._psutil_osx' extension 00:05:15 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 00:05:17 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 00:05:17 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 00:05:17 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 00:05:18 INFO - building 'psutil._psutil_posix' extension 00:05:18 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 00:05:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:05:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:05:18 INFO - ^ 00:05:18 INFO - 1 warning generated. 00:05:18 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 00:05:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:18 INFO - Successfully installed psutil 00:05:18 INFO - Cleaning up... 00:05:18 INFO - Return code: 0 00:05:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:18 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 0x10feaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde63f23090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd29f0>, '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 0x10fb32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdc68c8>, '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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 00:05:18 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 00:05:18 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 00:05:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZJgq0VvVTI/Render', 00:05:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:18 INFO - 'HOME': '/Users/cltbld', 00:05:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:18 INFO - 'LOGNAME': 'cltbld', 00:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:18 INFO - 'MOZ_NO_REMOTE': '1', 00:05:18 INFO - 'NO_EM_RESTART': '1', 00:05:18 INFO - 'PAGER': '/bin/cat', 00:05:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:18 INFO - 'PWD': '/builds/slave/test', 00:05:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:18 INFO - 'SHELL': '/bin/bash', 00:05:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDkqdjHCA2/Listeners', 00:05:18 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 00:05:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:18 INFO - 'USER': 'cltbld', 00:05:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:18 INFO - 'XPC_FLAGS': '0x0', 00:05:18 INFO - 'XPC_SERVICE_NAME': '0', 00:05:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:05:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:05:21 INFO - Installing collected packages: mozsystemmonitor 00:05:21 INFO - Running setup.py install for mozsystemmonitor 00:05:21 INFO - Successfully installed mozsystemmonitor 00:05:21 INFO - Cleaning up... 00:05:21 INFO - Return code: 0 00:05:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10feaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde63f23090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd29f0>, '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 0x10fb32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdc68c8>, '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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 00:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:05:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZJgq0VvVTI/Render', 00:05:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:21 INFO - 'HOME': '/Users/cltbld', 00:05:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:21 INFO - 'LOGNAME': 'cltbld', 00:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:21 INFO - 'MOZ_NO_REMOTE': '1', 00:05:21 INFO - 'NO_EM_RESTART': '1', 00:05:21 INFO - 'PAGER': '/bin/cat', 00:05:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:21 INFO - 'PWD': '/builds/slave/test', 00:05:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:21 INFO - 'SHELL': '/bin/bash', 00:05:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDkqdjHCA2/Listeners', 00:05:21 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 00:05:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:21 INFO - 'USER': 'cltbld', 00:05:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:21 INFO - 'XPC_FLAGS': '0x0', 00:05:21 INFO - 'XPC_SERVICE_NAME': '0', 00:05:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:22 INFO - Downloading/unpacking blobuploader==1.2.4 00:05:22 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 00:05:22 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 00:05:22 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 00:05:22 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 00:05:22 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 00:05:22 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 00:05:24 INFO - Downloading blobuploader-1.2.4.tar.gz 00:05:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:05:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:05:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:25 INFO - Downloading docopt-0.6.1.tar.gz 00:05:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:05:26 INFO - Installing collected packages: blobuploader, requests, docopt 00:05:26 INFO - Running setup.py install for blobuploader 00:05:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:05:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:05:26 INFO - Running setup.py install for requests 00:05:26 INFO - Running setup.py install for docopt 00:05:26 INFO - Successfully installed blobuploader requests docopt 00:05:26 INFO - Cleaning up... 00:05:27 INFO - Return code: 0 00:05:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:27 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 0x10feaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde63f23090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd29f0>, '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 0x10fb32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdc68c8>, '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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 00:05:27 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 00:05:27 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 00:05:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZJgq0VvVTI/Render', 00:05:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:27 INFO - 'HOME': '/Users/cltbld', 00:05:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:27 INFO - 'LOGNAME': 'cltbld', 00:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:27 INFO - 'MOZ_NO_REMOTE': '1', 00:05:27 INFO - 'NO_EM_RESTART': '1', 00:05:27 INFO - 'PAGER': '/bin/cat', 00:05:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:27 INFO - 'PWD': '/builds/slave/test', 00:05:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:27 INFO - 'SHELL': '/bin/bash', 00:05:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDkqdjHCA2/Listeners', 00:05:27 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 00:05:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:27 INFO - 'USER': 'cltbld', 00:05:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:27 INFO - 'XPC_FLAGS': '0x0', 00:05:27 INFO - 'XPC_SERVICE_NAME': '0', 00:05:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:27 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-Qq_rof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:27 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-MYnYn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:27 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-nee6FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:27 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-5JJwfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:27 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-ZqZtTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-FsM6Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-IKOjcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-ns_eFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-gvUSLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-SpCyNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-3Rtpwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-338YIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:28 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-mNE9ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:29 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-737U77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:29 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-TwfrLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:29 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-ua2lVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:29 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-2zXVqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:05:29 INFO - Running setup.py install for manifestparser 00:05:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:05:29 INFO - Running setup.py install for mozcrash 00:05:29 INFO - Running setup.py install for mozdebug 00:05:30 INFO - Running setup.py install for mozdevice 00:05:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:05:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:05:30 INFO - Running setup.py install for mozfile 00:05:30 INFO - Running setup.py install for mozhttpd 00:05:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:05:30 INFO - Running setup.py install for mozinfo 00:05:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:05:30 INFO - Running setup.py install for mozInstall 00:05:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:05:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:05:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:05:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:05:30 INFO - Running setup.py install for mozleak 00:05:31 INFO - Running setup.py install for mozlog 00:05:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:05:31 INFO - Running setup.py install for moznetwork 00:05:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:05:31 INFO - Running setup.py install for mozprocess 00:05:31 INFO - Running setup.py install for mozprofile 00:05:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:05:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:05:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:05:31 INFO - Running setup.py install for mozrunner 00:05:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:05:32 INFO - Running setup.py install for mozscreenshot 00:05:32 INFO - Running setup.py install for moztest 00:05:32 INFO - Running setup.py install for mozversion 00:05:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:05:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:05:32 INFO - Cleaning up... 00:05:32 INFO - Return code: 0 00:05:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10feaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde63f23090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd29f0>, '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 0x10fb32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdc68c8>, '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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 00:05:32 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 00:05:32 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 00:05:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZJgq0VvVTI/Render', 00:05:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:32 INFO - 'HOME': '/Users/cltbld', 00:05:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:32 INFO - 'LOGNAME': 'cltbld', 00:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:32 INFO - 'MOZ_NO_REMOTE': '1', 00:05:32 INFO - 'NO_EM_RESTART': '1', 00:05:32 INFO - 'PAGER': '/bin/cat', 00:05:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:32 INFO - 'PWD': '/builds/slave/test', 00:05:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:32 INFO - 'SHELL': '/bin/bash', 00:05:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDkqdjHCA2/Listeners', 00:05:32 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 00:05:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:32 INFO - 'USER': 'cltbld', 00:05:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:32 INFO - 'XPC_FLAGS': '0x0', 00:05:32 INFO - 'XPC_SERVICE_NAME': '0', 00:05:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-FMANTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-33mNfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-3bFBf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-kzyYJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-Ah1sww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-3AV9pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:33 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)) 00:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-X99Un0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:33 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)) 00:05:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:33 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-8_3DHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:34 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-TII_Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:34 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-CMPAqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:34 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)) 00:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:34 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-XGK8a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:34 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-OobFLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:34 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-q56SAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:34 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-nqAdah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:34 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-aOmEMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:35 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-9Gbxmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:35 INFO - Running setup.py (path:/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/pip-ESCdj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:05:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:37 INFO - Downloading blessings-1.5.1.tar.gz 00:05:37 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 00:05:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:05:37 INFO - Installing collected packages: blessings 00:05:37 INFO - Running setup.py install for blessings 00:05:38 INFO - Successfully installed blessings 00:05:38 INFO - Cleaning up... 00:05:38 INFO - Return code: 0 00:05:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:05:38 INFO - Reading from file tmpfile_stdout 00:05:38 INFO - Current package versions: 00:05:38 INFO - blessings == 1.5.1 00:05:38 INFO - blobuploader == 1.2.4 00:05:38 INFO - docopt == 0.6.1 00:05:38 INFO - manifestparser == 1.1 00:05:38 INFO - mozInstall == 1.12 00:05:38 INFO - mozcrash == 0.16 00:05:38 INFO - mozdebug == 0.1 00:05:38 INFO - mozdevice == 0.47 00:05:38 INFO - mozfile == 1.2 00:05:38 INFO - mozhttpd == 0.7 00:05:38 INFO - mozinfo == 0.9 00:05:38 INFO - mozleak == 0.1 00:05:38 INFO - mozlog == 3.0 00:05:38 INFO - moznetwork == 0.27 00:05:38 INFO - mozprocess == 0.22 00:05:38 INFO - mozprofile == 0.27 00:05:38 INFO - mozrunner == 6.11 00:05:38 INFO - mozscreenshot == 0.1 00:05:38 INFO - mozsystemmonitor == 0.0 00:05:38 INFO - moztest == 0.7 00:05:38 INFO - mozversion == 1.4 00:05:38 INFO - psutil == 3.1.1 00:05:38 INFO - requests == 1.2.3 00:05:38 INFO - wsgiref == 0.1.2 00:05:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10feaf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fe8c228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde63f23090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd29f0>, '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 0x10fb32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdc68c8>, '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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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 00:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:05:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZJgq0VvVTI/Render', 00:05:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:38 INFO - 'HOME': '/Users/cltbld', 00:05:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:38 INFO - 'LOGNAME': 'cltbld', 00:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:38 INFO - 'MOZ_NO_REMOTE': '1', 00:05:38 INFO - 'NO_EM_RESTART': '1', 00:05:38 INFO - 'PAGER': '/bin/cat', 00:05:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:38 INFO - 'PWD': '/builds/slave/test', 00:05:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:38 INFO - 'SHELL': '/bin/bash', 00:05:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDkqdjHCA2/Listeners', 00:05:38 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 00:05:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:38 INFO - 'USER': 'cltbld', 00:05:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:38 INFO - 'XPC_FLAGS': '0x0', 00:05:38 INFO - 'XPC_SERVICE_NAME': '0', 00:05:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:05:38 INFO - Cleaning up... 00:05:38 INFO - Return code: 0 00:05:38 INFO - Running post-action listener: _resource_record_post_action 00:05:38 INFO - Running post-action listener: _start_resource_monitoring 00:05:38 INFO - Starting resource monitoring. 00:05:38 INFO - ##### 00:05:38 INFO - ##### Running install step. 00:05:38 INFO - ##### 00:05:38 INFO - Running pre-action listener: _resource_record_pre_action 00:05:38 INFO - Running main action method: install 00:05:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:05:39 INFO - Reading from file tmpfile_stdout 00:05:39 INFO - Detecting whether we're running mozinstall >=1.0... 00:05:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:05:39 INFO - Reading from file tmpfile_stdout 00:05:39 INFO - Output received: 00:05:39 INFO - Usage: mozinstall [options] installer 00:05:39 INFO - Options: 00:05:39 INFO - -h, --help show this help message and exit 00:05:39 INFO - -d DEST, --destination=DEST 00:05:39 INFO - Directory to install application into. [default: 00:05:39 INFO - "/builds/slave/test"] 00:05:39 INFO - --app=APP Application being installed. [default: firefox] 00:05:39 INFO - mkdir: /builds/slave/test/build/application 00:05:39 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'] 00:05:39 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 00:06:19 INFO - Reading from file tmpfile_stdout 00:06:19 INFO - Output received: 00:06:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:06:19 INFO - Running post-action listener: _resource_record_post_action 00:06:19 INFO - ##### 00:06:19 INFO - ##### Running run-tests step. 00:06:19 INFO - ##### 00:06:19 INFO - Running pre-action listener: _resource_record_pre_action 00:06:19 INFO - Running main action method: run_tests 00:06:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:06:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:06:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:06:19 INFO - 2015-11-18 00:06:19.087 screenresolution[1637:8373] starting screenresolution argv=screenresolution get 00:06:19 INFO - 2015-11-18 00:06:19.090 screenresolution[1637:8373] Display 0: 1600x1200x32@60 00:06:19 INFO - 2015-11-18 00:06:19.097 screenresolution[1638:8375] starting screenresolution argv=screenresolution list 00:06:19 INFO - Available Modes on Display 0 00:06:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:06:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:06:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:06:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:06:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:06:19 INFO - Intel HD Graphics 3000: 00:06:19 INFO - Chipset Model: Intel HD Graphics 3000 00:06:19 INFO - Type: GPU 00:06:19 INFO - Bus: Built-In 00:06:19 INFO - VRAM (Total): 512 MB 00:06:19 INFO - VRAM (Dynamic, Max): 10 00:06:19 INFO - Vendor: Intel (0x8086) 00:06:19 INFO - Device ID: 0x0116 00:06:19 INFO - Revision ID: 0x0009 00:06:19 INFO - Displays: 00:06:19 INFO - Display: 00:06:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:06:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:06:19 INFO - Display Serial Number: 1600x1200 60 00:06:19 INFO - Main Display: Yes 00:06:19 INFO - Mirror: Off 00:06:19 INFO - Online: Yes 00:06:19 INFO - Rotation: Supported 00:06:19 INFO - Return code: 0 00:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:06:19 INFO - Python 2.7.3 00:06:19 INFO - Return code: 0 00:06:19 INFO - grabbing minidump binary from tooltool 00:06:19 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')]} 00:06:19 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 0x10fdd29f0>, '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 0x10fb32db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdc68c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:06:19 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 00:06:19 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 00:06:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:06:19 INFO - Return code: 0 00:06:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:06:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:06:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:06:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:06:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0018', '--webServer', 'localhost'] in /builds/slave/test/build 00:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0018 --webServer localhost 00:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZJgq0VvVTI/Render', 00:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:06:19 INFO - 'HOME': '/Users/cltbld', 00:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:06:19 INFO - 'LOGNAME': 'cltbld', 00:06:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:06:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:19 INFO - 'MOZ_NO_REMOTE': '1', 00:06:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:06:19 INFO - 'NO_EM_RESTART': '1', 00:06:19 INFO - 'PAGER': '/bin/cat', 00:06:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:19 INFO - 'PWD': '/builds/slave/test', 00:06:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:06:19 INFO - 'SHELL': '/bin/bash', 00:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pDkqdjHCA2/Listeners', 00:06:19 INFO - 'TMPDIR': '/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/', 00:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:06:19 INFO - 'USER': 'cltbld', 00:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:19 INFO - 'XPC_FLAGS': '0x0', 00:06:19 INFO - 'XPC_SERVICE_NAME': '0', 00:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 00:06:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0018', '--webServer', 'localhost'] with output_timeout 3600 00:06:19 INFO - mozversion INFO | application_buildid: 20151117223936 00:06:19 INFO - mozversion INFO | application_changeset: c699b2c839a9f8c2b964dd956de9084d3b93a13f 00:06:19 INFO - mozversion INFO | application_display_name: Nightly 00:06:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:06:19 INFO - mozversion INFO | application_name: Firefox 00:06:19 INFO - mozversion INFO | application_remotingname: firefox 00:06:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 00:06:19 INFO - mozversion INFO | application_vendor: Mozilla 00:06:19 INFO - mozversion INFO | application_version: 45.0a1 00:06:19 INFO - mozversion INFO | platform_buildid: 20151117223936 00:06:19 INFO - mozversion INFO | platform_changeset: c699b2c839a9f8c2b964dd956de9084d3b93a13f 00:06:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 00:06:19 INFO - mozversion INFO | platform_version: 45.0a1 00:06:19 INFO - 2015-11-18 00:06:19,848 DEBUG : using testdate: 1447833979 00:06:19 INFO - 2015-11-18 00:06:19,848 DEBUG : actual date: 1447833979 00:06:19 INFO - 2015-11-18 00:06:19,858 INFO : starting webserver on 'localhost:49267' 00:06:19 INFO - 2015-11-18 00:06:19,859 INFO : Starting test suite t-yosemite-r5-0018 00:06:19 INFO - 2015-11-18 00:06:19,859 INFO : Starting test dromaeo_css 00:06:19 INFO - 2015-11-18 00:06:19,859 DEBUG : operating with platform_type : mac_ 00:06:19 INFO - 2015-11-18 00:06:19,860 INFO : Initialising browser for dromaeo_css test... 00:06:19 INFO - 2015-11-18 00:06:19,884 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmpgy0nCP/profile http://localhost:49267/getInfo.html 00:06:23 INFO - 2015-11-18 00:06:23,398 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:06:23 INFO - 2015-11-18 00:06:23,398 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:06:23 INFO - 2015-11-18 00:06:23,398 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 00:06:23 INFO - 2015-11-18 00:06:23,398 DEBUG : BROWSER_OUTPUT: __metrics 00:06:23 INFO - 2015-11-18 00:06:23,414 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:06:24 INFO - 2015-11-18 00:06:24,184 INFO : Browser initialized. 00:06:24 INFO - 2015-11-18 00:06:24,184 INFO : Running cycle 1/1 for dromaeo_css test... 00:06:24 INFO - 2015-11-18 00:06:24,184 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmpgy0nCP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:06:36 INFO - 2015-11-18 00:06:36,237 DEBUG : BROWSER_OUTPUT: RSS: Main: 229945344 00:06:36 INFO - 2015-11-18 00:06:36,238 DEBUG : BROWSER_OUTPUT: 00:07:28 INFO - 2015-11-18 00:07:28,037 DEBUG : BROWSER_OUTPUT: 1447834048036 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] 00:09:38 INFO - 2015-11-18 00:09:38,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 00:09:39 INFO - 2015-11-18 00:09:39,396 DEBUG : BROWSER_OUTPUT: RSS: Main: 337809408 00:09:39 INFO - 2015-11-18 00:09:39,396 DEBUG : BROWSER_OUTPUT: 00:12:42 INFO - 2015-11-18 00:12:42,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 00:12:42 INFO - 2015-11-18 00:12:42,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 370569216 00:12:43 INFO - 2015-11-18 00:12:42,806 DEBUG : BROWSER_OUTPUT: 00:15:45 INFO - 2015-11-18 00:15:45,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 00:15:45 INFO - 2015-11-18 00:15:45,632 DEBUG : BROWSER_OUTPUT: RSS: Main: 329613312 00:15:45 INFO - 2015-11-18 00:15:45,633 DEBUG : BROWSER_OUTPUT: 00:18:47 INFO - 2015-11-18 00:18:47,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 00:18:48 INFO - 2015-11-18 00:18:48,339 DEBUG : BROWSER_OUTPUT: RSS: Main: 330899456 00:18:48 INFO - 2015-11-18 00:18:48,339 DEBUG : BROWSER_OUTPUT: 00:21:51 INFO - 2015-11-18 00:21:51,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 00:21:52 INFO - 2015-11-18 00:21:52,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 330420224 00:21:52 INFO - 2015-11-18 00:21:52,036 DEBUG : BROWSER_OUTPUT: 00:24:54 INFO - 2015-11-18 00:24:54,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 00:24:55 INFO - 2015-11-18 00:24:55,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 375648256 00:24:55 INFO - 2015-11-18 00:24:55,071 DEBUG : BROWSER_OUTPUT: 00:24:55 INFO - 2015-11-18 00:24:55,072 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:24:55 INFO - 2015-11-18 00:24:55,073 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:24:55 INFO - 2015-11-18 00:24:55,073 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:24:55 INFO - 2015-11-18 00:24:55,073 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:24:55 INFO - 2015-11-18 00:24:55,076 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2758.144975057732;2875.5111631022723;2891.696371880953;2896.797224194307;2909.2726818295414;4674.85975420737;4734.526547345264;4772.260299653555;4855.247436647316;4910.729909854961;4822.6624136310475;4822.855314340575;4854.223324268127;4952.05910876934;4973.104841128605;4429.114177164563;4433.866983990485;4465.8660240192685;4507.887302817439;4527.411436513249;4480.171168333853;4521.502634710179;4540.160070386973;4600.401947746805;4612.400387949562;4279.614834664895;4351.6518678505645;4390.385346051556;4509.301058335946;4547.045120524694;4484.1031793641405;4488.640908727294;4532.274836026253;4537.342085397599;4542.04617030424;4457.442819647544;4470.664700147469;4477.126960242754;4513.684042117053;4560.429946256718;4659.138059459011;4757.333973243749;4826.975865120687;4847.054824309261;4906.582940450066;5142.485751424865;5142.845714628567;5163.664361816507;5202.713850738208;5205.713685747282;5216.087184742655;5228.607854410934;5251;5269.262303277545;5320.467953204688;4568.931466027979;4713.717176969324;4730.432348118248;4741.620670346364;4796.424429068499;5279.366476022902;5321.733913304397;5325.467453254643;5351.545118664879;5358.30342055538;5038.84883453497;5065.493450654905;5067.974660126676;5109.744512774347;5110.744462776846;5055.51972562606;5062.9746851266245;5139.331886854685;5184.351956005499;5224.738763061908;5128.1282182029145;5133.153029750124;5164.32863727713;5174.715390653475;5186.377634683862;5128.871778205575;5132.897342053213;5141.434442211354;5163.561097306771;5207.817726379559;3814.5803961564206;3889.202713443737;3891.455196272524;3928.744631598937;3961.465202197724;3588.6949609282983;3604.873829415958;3646.927061458756;3684.907877303035;3716.1452865840465;4876.463589005207;4888.315635810989;4918.643646751956;4927.43334516528;4929.926051109236;5043.949560504348;5116.283720279164;5167.250748641502;5225.764840582183;5229.895402091937;4780.617550595944;4820.180569303227;4832.251001094836;4856.562909338177;4941.061198372297;4594.471635761864;4599.195140850338;4631.467381251132;4641.234196357631;4697.13103075932;5243.056249875059;5338.386085600206;5376.435474275301;5420.7289635518855;5424.376196737347;5110.66780659256;5157.200633901752;5157.716325602128;5179.067767801832;5194.818181363634;5354.919676204782;5408.13469844823;5411.675299482044;5413.323334583177;5428.647137936022;4945.431275403231;5003.324551185543;5066.265391518283;5161.0968080585;5162.483751624807;5026.974865125651;5083.898322033612;5109.8978020438635;5143.125668636266;5158.509941555546;5040.873978150576;5058.215976523645;5077.644315798436;5085.3134826797905;5087.3386459759995;4878.170710979071;5032.245163225399;5037.899242015213;5060.3927528696795;5082.872928176826;4840.515948405131;4917.26241063829;4955.603551715926;4960.925586116284;4968.900621987467;5053.8736531587;5095.490450954875;5102.744862756773;5108.56577190943;5121.487851214849;4799.256115302133;4942.703437793743;4950.430700469348;4972.5027497249985;4972.801087956441 00:24:55 INFO - 2015-11-18 00:24:55,076 DEBUG : BROWSER_OUTPUT: |1;ext.html;502.2315856739189;513.0175713508634;513.3993227923329;521.7208793295588;537.2961420539092;28104.437911241763;28658.42683146336;28683.713162868364;34513.30973380531;35071.649283507155;38281.83195268638;38460.80769596155;38738.22523549527;38790.612093879055;38837.80581097091;8070.233327833861;8265.338772898183;8301.584920753969;8346.791330216764;8363.372747043966;7590.886136707926;7819.100803407596;9850.408975461496;10134;10154;9800.90199098007;9960.05379488951;9990.700278991642;10030.598776048986;10041.949790251076;7524.360429363511;7747.302742753123;9906.851397229048;9929.453880036668;9942.900570994307;9837.704868853945;10019.44893030883;10024.348417352921;10033.949830250802;10132.54403551842;35453;35658.64341356579;35733;35791.64208357909;35887.4616880747;2697.892084316625;2706.039356028601;2779.4580056888913;2810.395764910554;3155.5108958111527;24973.875130624412;24984.875075624688;25271.36821579457;25426.491470170495;26016.869915650488;2109.314472796347;2115.0482282972725;2128.138104067855;2143.764185939561;2293.0598454633687;230242;232186;232213;232899;233337.83331083404;46900.2964955526;47806;48001.71981082078;53464;54206.45793542093;60434;62371;62500.374996250364;62526.68736656378;62619.6869015652;14968.550943471495;14972.925135374253;15145;15148.242587870562;15288.617784555252;11403.315801051964;11473.598424055119;11474.827877581843;11478.426078696031;11493.712657183638;17554.473365799047;17752.644947100987;17905.820941790676;17945.461636150936;17983.1008449577;7638.197989211053;7858.646360913658;7867;7924.881126783102;7943.682252709942;827.1893544326593;847.563504795031;861.9569021548898;887.272436601993;931.8602209668468;23581.88209058944;23759.406014849767;24534.754652453605;24582.50834983326;24750.752492474843;906.6509393883271;963.2823546457934;1016.1210552871713;1026.9832865463138;1064.3720205079042;12779.552715654907;12827.294498802656;12925.806112908314;12966.546170883974;12969.935150324189;253414;255633;258786;259823;260289;47381;47540.28689569659;47594.5240547597;47737.522624774;47864.5213547867;1269.8920591749804;1278.5397256987478;1289.3810970733912;1304.1197191895433;1305.1842598376015;24162.154324598556;24538.263852084467;24550.754492455562;24609.753902460747;24790.628140578265;41374.82814648169;41460.58539414567;41465.58534414617;41657.58342416537;41775.37336940009;245449;246730;246784;247477;248218;25056.37359066038;25466.745332546438;27479;28621.856890715415;28894.7110528892;34104;34801.82599086988;34885.82557087198;35172.29655406826;35425;28936.42127157403;30156.09531714052;30168.396632067674;30255.69744302529;30340.84829575838;27537;31413.214669633442;31801.68198317987;31875.52186717155;32063;30455.543166852072;30630.540541892336;31115.68884311128;31126.221844453165;31171.53242701316;26619.20142395731;27817.304567385978;27855.582166267115;27969.300767480974;28063.43873122567;21590.676139858228;21676.34970950874;21678.24126155577;21720.456988575414;21792.564148717254 00:24:55 INFO - 2015-11-18 00:24:55,081 DEBUG : BROWSER_OUTPUT: |2;jquery.html;297.1338548132195;298.7132352941176;303.3356948283258;303.64473565927864;307.44352721573944;15529.456469023586;15851.68296634068;15955.920220398897;16505.33978640856;16549.751753723674;10145;10479.004494573022;10581.78836423271;10592.152627789777;15857.20713964303;3896.7272290939645;3941.7043721720916;4099.487564054493;4282.807273672693;4373.059792144688;3524.559430071241;4375.540568240337;4378.956210437903;4400.845970391037;4416.690831641787;3055.3278278778744;3130.514770210621;3138.686131386866;4309.956900430987;4353.804078816461;4230.873073807776;4303.246931786956;4359.760213188273;4375.9562404375865;4404.471463424394;3678.062094165997;3683.189698266377;3694.5751238607636;3695.63043695631;3710.07248187953;10055.849162262572;10370.118539924115;10378.06597406237;11614.303141811433;11621.47703353351;1572.3553343129263;1625.5692241555996;1628.696745576785;1666.0253751555354;1692.6022384739576;8581.570921453902;8612.784680382978;8731.432456890281;8756.956215218883;9006.369554131148;1347.9258640774754;1406.3319923036477;1406.4725727852056;1471.8896082793833;1501.06183635228;49648;50865;51735.48264517344;52019.47980520222;52255.73872130653;5805;5810.273715785527;5832.679202643811;5900.527957763368;5903.645781253139;6694.430973367221;6696.096027036385;6708.664566771642;6740.528163028541;6752.62860542665;4747.145513807548;4776.379070720854;4790.257510085942;4790.784414701347;4821.397325334333;4883.389576302962;4887.706737595756;4928.507149285043;4936.703797772145;5031.069252188357;2656.123479251842;2665.586834040727;2665.853378064225;2677.303900985719;2685.78513718902;929.6142101027998;931.4318265857821;933.244072301438;942.34036174678;1004.3120462483222;379.91072098056935;380.1560535610939;420.30439622424933;423.91097869447145;424.72392944585647;10228.33515821484;10302.124319432782;10638.893611063944;10822.134229261641;10834.783304333869;378.1623703496713;387.0065046862516;388.47361824727653;409.17142785858874;425.0478927203043;5603.607747457639;5611.158326251013;5675.148727690879;5693.345265294462;5755.913661295084;426784;427876;429038;440208;445532;48487;49225.34161490683;65154.674226628566;65950;65975.34024659693;451.3906226594072;451.97740112994876;453.7050916903973;456.30641425033764;457.26608792886935;9813.509324533887;9912.900870991198;9946.502674866084;10036.64871729486;10096;31499.37001259916;31552.842235788674;31649;32025.519617205293;32820.83589582037;41490.37764433596;42610.78694606507;43729.78135109304;43747.56252437562;43804;5507.752151153128;5655.462731040545;5661.688607126647;5670.376258611632;5683.204351390726;10388;10654.254202205771;10746.623868164577;10774;10832.295900766425;8937.73186804397;8969.416987895765;9286.582103805209;9361.578728957349;9449.102335278138;8937.687180948635;8961.283097352065;9020.774480638036;9046.457212567268;9329.533523323942;7517.924820751722;8833.469991800512;9303.441793492411;9387.15515603599;9387.389819661701;5524.8342549723575;5535.197396377423;5584;5599;5622.353429355677;4210.7473551587;9171.63313467454;9223.953880230825;9301.581428835583;9414.529273536433 00:24:55 INFO - 2015-11-18 00:24:55,081 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1446.1034158821533;1518.3167574591432;1577.1246957938347;1615.3054186699715;1619.7408414653655;5783.624064435809;5978.282606087265;6070.484008859246;6526.28210896801;6577.276499585042;6112.908306375408;6158.384161583839;6163.784267550625;6404.23149222094;6664.333566643345;1922.1062206074173;1926.412444204517;1968.6358023765576;1972.1914015253749;1976.3873199308262;1744.4504980930967;1972.4181366496846;1980.6236815005175;2018.5357367805414;2052.9794702053014;1744.8571185873209;1919.5489060070872;1943.5335519475295;1950.161430584848;1964.9803501965011;1883.3878989328523;1915.5306949797318;1922.8942408167545;1924.7401600783855;1940.0978544976654;1982.0684278389133;2017.7074324223051;2021.1410150686047;2035.0943829995658;2038.449618602969;6532.706028228741;6590.967045164792;6648.202215734094;6669.866602667919;6674;4059.4925634295714;4146.170765846843;4156.750594964282;4176.686748493845;4180.602842729936;2537.6827896512937;2589.585666293384;2592.7925765938867;2599.8050146239107;2601.258641287243;794.3208556684067;803.2890891560952;831.7837362285788;835.2274146414603;839.8698201778734;8735.737927862174;8792.296616270747;8823.382363234576;8825.867611985761;8830.42602230853;3629.165291982859;3705.8517659293866;3809.5238095238096;3809.8476060957805;3820.2359528094494;7634.580098094658;7642.961785191039;7681.0782706074515;7687.346575541142;7692.46152769312;4236.301010333261;4242.300020496584;4261.2542805009;4290.849820256276;4295.055087880662;3826.215625796705;3855.63371479709;3890.980545097313;3897.142628621755;3905.941410878839;3083.1699525283457;3149.3228955774616;3151.2437015116666;3157.3053928135773;3176.0630613968933;974.0892265731422;1027.7944411117805;1038.0346277961416;1040.4225654761528;1050.9211809114347;785.4658831994185;791.2087912087912;793.6031984007996;843.2242337049929;995.8290925781721;5742.310922689304;6267.843303917439;6290.591111577733;6343.492520598341;6375.840603984938;980.1668581705636;1013.964511242103;1019;1029.9279050466396;1043.7181960870523;4750.192467280502;4924.1875090610365;4959.280904268933;4985.750712464434;5004.049230646166;7524.586147761816;7668.041494813148;7814.882776758353;7817.57003364809;7835.882461763078;7667.118281397599;7694.846103077907;7703.075630924325;7725.652345644459;7768.145503994556;6216.782412615627;6252.968735156295;6253.74985000604;6263.342349053284;6277.403646653561;5942.168096466412;6024.8795024100145;6032.034874420072;6098.146259523582;6106.3588323227195;6743.966280168568;6931.757388491378;6980.092587963735;7009.2990700929495;7036.050133231948;6973.686184121625;7185.820354491179;7203.063601731951;7252.4560657949805;7274.8908766369605;5756.366799651951;5839.503642190291;5857.414258574108;5860.2967643883;5883.294004719461;6357.8728425432155;6358.300586935341;6412.03819427071;6423.96788016057;6439.710213040518;5849.912251316318;5999.790007349722;6051.3948605140895;6059.484943779652;6092.299385570539;5038.874028149179;5861.648301101947;5920.526357891445;5932.584719069796;5946.048632218824;5977.9402205977385;5981.132735753378;5992.250968628921;5997.13041608973;6038.879222415615;5290.074237008431;5298.258243845788;5311.41574426805;5348.090824559912;5354.437784032621;5452.700101494456;5552.7223638818705;5593.161025846156;5606.074997625346;5631.859203519781 00:24:55 INFO - 2015-11-18 00:24:55,084 DEBUG : BROWSER_OUTPUT: |4;prototype.html;272.15902860162095;277.9583062540617;281.41887003338115;281.65778579026494;283.7517172474086;5489.560835133189;5597.972010139943;5628.183913332569;5641.18202860585;5649.293838270216;5438.755256013479;5617.325920889499;5645.5483561315095;5677.48902598766;5691.715414229282;4324.243257429937;4333.068390296085;4341.826326946918;4346.282863327548;4388.451443569554;4124.298869192229;4213.873583792491;4226.218149642311;4323.113761678848;4330.437043184382;4042.4138499917494;4192.706510544263;4195.328747400416;4234.978825105885;4264.872053838374;4256.9574304257185;4266.552012038722;4275.465566804134;4292.334688123346;4305.182015417076;3702.740808143431;3709.666130048309;3716.7955762433057;3720.274546463441;3733.906652333686;5262.526372626482;5448.782048718046;5471.8084867029465;5492.286002819608;5493.890122197534;4849.733264670442;4880.487548807395;4880.902381952376;4886.071646387175;4889.071076495455;5896.734646940898;5900.704964751788;5908.97045514774;5924.437178468082;5990.371011043821;4026.5570787213383;4035.556088830226;4036.112055347848;4050.129222217208;4055.898602534931;5910.08393698973;6251.374862513758;6253.562250642457;6261.092141639437;6262.780802671885;4101.487314085739;4107.404426358161;4142.440770496005;4152.418661387408;4155.646770024521;4197.706160568792;4201.68487363449;4210.473690788652;4223.493180818322;4233.195692818416;4836.782344794493;4839.637027222972;4862.222044472867;4871.634627402959;4872.756362181947;5762.732198916232;5911.408859114054;5948.821535353946;5950.9107363389585;5959.165716799652;1448.8840892728556;1478.4381934864682;1487.1077353587762;1488.5608745420127;1492.514932646894;969.1519920069939;970.7767213540925;980.6371642492323;982.5676702250987;989.980200395988;5722.227499287626;5744.971275143681;5749.8562535936935;5755.65466072037;5755.913661295084;5943.791967281124;6180;6180.072989051679;6201.534884883652;6208.037754148114;5557.499825015768;5644.915326270109;5702.54379649627;5747.85630359236;5803.82588522345;3343.030521148888;3354.5974483062187;3370.915727106842;3377.206356506219;3382.729381649462;6430.131932189094;6434.581752186093;6445.613263204223;6452.322506136882;6454.515911306671;6141.232345956755;6360.427561519486;6361.5546911716665;6384.3934826191435;6389.9552143313695;6417.582857114273;6417.775377861846;6424.614523128721;6426.839329016812;6440.291567927524;6210.4100110489435;6221.813345599639;6230.563860529719;6247.468965137832;6263.467605253604;5885.705714714161;5986.341502434641;6031.517478601789;6057.030875059969;6116.724747386289;6441.066045423481;6453.386928241997;6471.7734879279;6484.41131922682;6489.707963141575;3997.600239975979;4007.0984028593334;4026.879193624196;4038.051058001426;4057.3711074783455;6087.604305720114;6199.535034872493;6206.658633775186;6222.719977601109;6245.094461303176;6005.669688167192;6009.969950150221;6041.848953776191;6047.697615119138;6061.848453788691;6032.638041717511;6032.698365081641;6042.546808989256;6043.395660433922;6057;5686.402927692533;5857.765689372548;5875.20684707559;5879.176915231786;5902.1146827976145;6019.638821670714;6043.214382130295;6045.758169673164;6063.636181829104;6063.818085457443;5913.822585322448;5927.31835838884;5944.6730429826775;5949.2266005419015;5949.405059494016 00:24:55 INFO - 2015-11-18 00:24:55,086 DEBUG : BROWSER_OUTPUT: |5;yui.html;627.8399008252895;669.3373560175427;679.3274658088491;703.6622421237803;704.5314865614366;12258.632241032772;12755.043371747133;12766.234025958438;12803.615891523257;12816.23102613844;11647.708807279821;11712.824307635392;11758.23571467854;11759.7060073498;11811.291322520654;622.8909940760349;632.2034236861565;784.8783438567003;789.6170357376682;812.4069429316603;775.8681024225867;780.9726659566917;786.7167819584945;787.4330482052912;795.5624406576388;824.2375802382802;824.47233770387;824.4846970643348;832.9541875196862;834.0408530190269;645.3514218210692;655.6590572902088;811.8011087283594;826.8139668574582;828.8052307707684;620.2587907450599;620.2897682153908;620.736187120472;625.5871125057486;625.7465726380777;12225.572104976372;12319.199252048587;12342.75314493714;12401.689957751038;12424.254544727346;8387.790305242357;8681.696140635111;8713.085126061736;10211.642592509226;10975.560977560888;7978.720744773905;8063.435559510778;8129.918700813035;8160;8191.959040204761;2583.302508322742;2589.6245044468633;2685.691145518271;2749.738774816389;2752.981396883166;39347.40978885319;39703;39948.60051399478;39985;40128.79935600333;5934.554908381802;5945.970270148708;5994.550408719363;6043.939560604425;6155.840917591323;10819.350838949687;10903.727406814893;10915.072218861485;10944.288621239593;10959.780804383867;5438.5102908844065;5492.69790161537;5528.75120619573;5663.943360566424;5665.943340566624;3429.794212347267;3486.651334866493;3521.0845180252804;3618.0593045808278;3624.2389098289127;2426.102342133422;2439.499902519979;2445.4864478459367;2453.705555333371;2459.8524088554746;345.16470142255804;345.9757816952789;346.1968233697797;347.27073146392877;350.50753691064097;501.97239151847;518.1864472777703;531.2827682628421;558.9776408943596;564.971751412436;6524.934750652433;7289.198188199294;7630.427717921179;7783.066032076187;7891.644875980594;385.4218671992012;512.5489569179099;544.9918251226235;552.9612927095145;554.8002719021149;3341.665833416639;3459.567554055743;3589.515415418937;3611.8013509257244;3741;53106.203406948924;53377.46622533725;53397.46602533925;53426.198607020924;53655.731721341144;46362.5363746365;47000;47135.76432117886;47173.76413117912;47584;41398.37902431466;41856.16287674291;41984;42214.15571688549;43003.13993720108;7420.183779784327;7431.516951398142;7454.217307182667;7683.193264707125;7803.882941755992;30338;31344;31414.214644633154;31457.528137077505;31471.37057258888;39251.41122883216;41147;42130;42707.786461067495;42768;6156.476699480415;6333.493320534254;6390.297067322498;6580.638064906476;6697.3637504437;9445.433274003582;9609.663661771805;9731.610735570497;9754.146712124673;9947.751306217402;8920.509371984603;9043.819123617359;9049.54752262371;9055.320850936338;9064.864027039468;8739.956300218459;8811.33914956368;9015.729528114167;9179.17387435134;9186.173244408035;9003.684871029482;9051.366404351633;9125.406848554823;9285.210757085724;9603.423794572349;7829;7950.960245198737;8025.541255113099;8183.590820459072;8568.35737319691;7670.058596969751;8082.919170808216;8110.797230069295;8143.307818835466;8250.298724608476 00:24:55 INFO - 2015-11-18 00:24:55,086 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:24:55 INFO - 2015-11-18 00:24:55,086 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:24:55 INFO - 2015-11-18 00:24:55,086 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1032 00:24:55 INFO - 2015-11-18 00:24:55,086 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:24:55 INFO - 2015-11-18 00:24:55,086 DEBUG : BROWSER_OUTPUT: __startTimestamp1447835095072__endTimestamp 00:24:55 INFO - 2015-11-18 00:24:55,087 DEBUG : BROWSER_OUTPUT: 00:24:55 INFO - 2015-11-18 00:24:55,087 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:24:55 INFO - 2015-11-18 00:24:55,087 DEBUG : BROWSER_OUTPUT: Number of tests: 6 00:24:55 INFO - 2015-11-18 00:24:55,087 DEBUG : BROWSER_OUTPUT: 00:24:55 INFO - 2015-11-18 00:24:55,087 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4818.44 Median:4960.93 stddev:521.46 (10.5%) stddev-sans-first:497.39 00:24:55 INFO - 2015-11-18 00:24:55,088 DEBUG : BROWSER_OUTPUT: Values: 2758.1 2875.5 2891.7 2896.8 2909.3 4674.9 4734.5 4772.3 4855.2 4910.7 4822.7 4822.9 4854.2 4952.1 4973.1 4429.1 4433.9 4465.9 4507.9 4527.4 4480.2 4521.5 4540.2 4600.4 4612.4 4279.6 4351.7 4390.4 4509.3 4547.0 4484.1 4488.6 4532.3 4537.3 4542.0 4457.4 4470.7 4477.1 4513.7 4560.4 4659.1 4757.3 4827.0 4847.1 4906.6 5142.5 5142.8 5163.7 5202.7 5205.7 5216.1 5228.6 5251.0 5269.3 5320.5 4568.9 4713.7 4730.4 4741.6 4796.4 5279.4 5321.7 5325.5 5351.5 5358.3 5038.8 5065.5 5068.0 5109.7 5110.7 5055.5 5063.0 5139.3 5184.4 5224.7 5128.1 5133.2 5164.3 5174.7 5186.4 5128.9 5132.9 5141.4 5163.6 5207.8 3814.6 3889.2 3891.5 3928.7 3961.5 3588.7 3604.9 3646.9 3684.9 3716.1 4876.5 4888.3 4918.6 4927.4 4929.9 5043.9 5116.3 5167.3 5225.8 5229.9 4780.6 4820.2 4832.3 4856.6 4941.1 4594.5 4599.2 4631.5 4641.2 4697.1 5243.1 5338.4 5376.4 5420.7 5424.4 5110.7 5157.2 5157.7 5179.1 5194.8 5354.9 5408.1 5411.7 5413.3 5428.6 4945.4 5003.3 5066.3 5161.1 5162.5 5027.0 5083.9 5109.9 5143.1 5158.5 5040.9 5058.2 5077.6 5085.3 5087.3 4878.2 5032.2 5037.9 5060.4 5082.9 4840.5 4917.3 4955.6 4960.9 4968.9 5053.9 5095.5 5102.7 5108.6 5121.5 4799.3 4942.7 4950.4 4972.5 4972.8 00:24:55 INFO - 2015-11-18 00:24:55,088 DEBUG : BROWSER_OUTPUT: 00:24:55 INFO - 2015-11-18 00:24:55,088 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40021.75 Median:28640.14 stddev:64052.06 (223.6%) stddev-sans-first:64163.01 00:24:55 INFO - 2015-11-18 00:24:55,091 DEBUG : BROWSER_OUTPUT: Values: 502.2 513.0 513.4 521.7 537.3 28104.4 28658.4 28683.7 34513.3 35071.6 38281.8 38460.8 38738.2 38790.6 38837.8 8070.2 8265.3 8301.6 8346.8 8363.4 7590.9 7819.1 9850.4 10134.0 10154.0 9800.9 9960.1 9990.7 10030.6 10041.9 7524.4 7747.3 9906.9 9929.5 9942.9 9837.7 10019.4 10024.3 10033.9 10132.5 35453.0 35658.6 35733.0 35791.6 35887.5 2697.9 2706.0 2779.5 2810.4 3155.5 24973.9 24984.9 25271.4 25426.5 26016.9 2109.3 2115.0 2128.1 2143.8 2293.1 230242.0 232186.0 232213.0 232899.0 233337.8 46900.3 47806.0 48001.7 53464.0 54206.5 60434.0 62371.0 62500.4 62526.7 62619.7 14968.6 14972.9 15145.0 15148.2 15288.6 11403.3 11473.6 11474.8 11478.4 11493.7 17554.5 17752.6 17905.8 17945.5 17983.1 7638.2 7858.6 7867.0 7924.9 7943.7 827.2 847.6 862.0 887.3 931.9 23581.9 23759.4 24534.8 24582.5 24750.8 906.7 963.3 1016.1 1027.0 1064.4 12779.6 12827.3 12925.8 12966.5 12969.9 253414.0 255633.0 258786.0 259823.0 260289.0 47381.0 47540.3 47594.5 47737.5 47864.5 1269.9 1278.5 1289.4 1304.1 1305.2 24162.2 24538.3 24550.8 24609.8 24790.6 41374.8 41460.6 41465.6 41657.6 41775.4 245449.0 246730.0 246784.0 247477.0 248218.0 25056.4 25466.7 27479.0 28621.9 28894.7 34104.0 34801.8 34885.8 35172.3 35425.0 28936.4 30156.1 30168.4 30255.7 30340.8 27537.0 31413.2 31801.7 31875.5 32063.0 30455.5 30630.5 31115.7 31126.2 31171.5 26619.2 27817.3 27855.6 27969.3 28063.4 21590.7 21676.3 21678.2 21720.5 21792.6 00:24:55 INFO - 2015-11-18 00:24:55,092 DEBUG : BROWSER_OUTPUT: 00:24:55 INFO - 2015-11-18 00:24:55,092 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22229.91 Median:4375.75 stddev:71129.55 (1625.5%) stddev-sans-first:71310.02 00:24:55 INFO - 2015-11-18 00:24:55,092 DEBUG : BROWSER_OUTPUT: Values: 297.1 298.7 303.3 303.6 307.4 15529.5 15851.7 15955.9 16505.3 16549.8 10145.0 10479.0 10581.8 10592.2 15857.2 3896.7 3941.7 4099.5 4282.8 4373.1 3524.6 4375.5 4379.0 4400.8 4416.7 3055.3 3130.5 3138.7 4310.0 4353.8 4230.9 4303.2 4359.8 4376.0 4404.5 3678.1 3683.2 3694.6 3695.6 3710.1 10055.8 10370.1 10378.1 11614.3 11621.5 1572.4 1625.6 1628.7 1666.0 1692.6 8581.6 8612.8 8731.4 8757.0 9006.4 1347.9 1406.3 1406.5 1471.9 1501.1 49648.0 50865.0 51735.5 52019.5 52255.7 5805.0 5810.3 5832.7 5900.5 5903.6 6694.4 6696.1 6708.7 6740.5 6752.6 4747.1 4776.4 4790.3 4790.8 4821.4 4883.4 4887.7 4928.5 4936.7 5031.1 2656.1 2665.6 2665.9 2677.3 2685.8 929.6 931.4 933.2 942.3 1004.3 379.9 380.2 420.3 423.9 424.7 10228.3 10302.1 10638.9 10822.1 10834.8 378.2 387.0 388.5 409.2 425.0 5603.6 5611.2 5675.1 5693.3 5755.9 426784.0 427876.0 429038.0 440208.0 445532.0 48487.0 49225.3 65154.7 65950.0 65975.3 451.4 452.0 453.7 456.3 457.3 9813.5 9912.9 9946.5 10036.6 10096.0 31499.4 31552.8 31649.0 32025.5 32820.8 41490.4 42610.8 43729.8 43747.6 43804.0 5507.8 5655.5 5661.7 5670.4 5683.2 10388.0 10654.3 10746.6 10774.0 10832.3 8937.7 8969.4 9286.6 9361.6 9449.1 8937.7 8961.3 9020.8 9046.5 9329.5 7517.9 8833.5 9303.4 9387.2 9387.4 5524.8 5535.2 5584.0 5599.0 5622.4 4210.7 9171.6 9224.0 9301.6 9414.5 00:24:55 INFO - 2015-11-18 00:24:55,092 DEBUG : BROWSER_OUTPUT: 00:24:55 INFO - 2015-11-18 00:24:55,092 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4617.07 Median:5860.97 stddev:2326.18 (39.7%) stddev-sans-first:2320.50 00:24:55 INFO - 2015-11-18 00:24:55,092 DEBUG : BROWSER_OUTPUT: Values: 1446.1 1518.3 1577.1 1615.3 1619.7 5783.6 5978.3 6070.5 6526.3 6577.3 6112.9 6158.4 6163.8 6404.2 6664.3 1922.1 1926.4 1968.6 1972.2 1976.4 1744.5 1972.4 1980.6 2018.5 2053.0 1744.9 1919.5 1943.5 1950.2 1965.0 1883.4 1915.5 1922.9 1924.7 1940.1 1982.1 2017.7 2021.1 2035.1 2038.4 6532.7 6591.0 6648.2 6669.9 6674.0 4059.5 4146.2 4156.8 4176.7 4180.6 2537.7 2589.6 2592.8 2599.8 2601.3 794.3 803.3 831.8 835.2 839.9 8735.7 8792.3 8823.4 8825.9 8830.4 3629.2 3705.9 3809.5 3809.8 3820.2 7634.6 7643.0 7681.1 7687.3 7692.5 4236.3 4242.3 4261.3 4290.8 4295.1 3826.2 3855.6 3891.0 3897.1 3905.9 3083.2 3149.3 3151.2 3157.3 3176.1 974.1 1027.8 1038.0 1040.4 1050.9 785.5 791.2 793.6 843.2 995.8 5742.3 6267.8 6290.6 6343.5 6375.8 980.2 1014.0 1019.0 1029.9 1043.7 4750.2 4924.2 4959.3 4985.8 5004.0 7524.6 7668.0 7814.9 7817.6 7835.9 7667.1 7694.8 7703.1 7725.7 7768.1 6216.8 6253.0 6253.7 6263.3 6277.4 5942.2 6024.9 6032.0 6098.1 6106.4 6744.0 6931.8 6980.1 7009.3 7036.1 6973.7 7185.8 7203.1 7252.5 7274.9 5756.4 5839.5 5857.4 5860.3 5883.3 6357.9 6358.3 6412.0 6424.0 6439.7 5849.9 5999.8 6051.4 6059.5 6092.3 5038.9 5861.6 5920.5 5932.6 5946.0 5977.9 5981.1 5992.3 5997.1 6038.9 5290.1 5298.3 5311.4 5348.1 5354.4 5452.7 5552.7 5593.2 5606.1 5631.9 00:24:55 INFO - 2015-11-18 00:24:55,092 DEBUG : BROWSER_OUTPUT: 00:24:55 INFO - 2015-11-18 00:24:55,093 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4979.84 Median:5746.41 stddev:1531.01 (26.6%) stddev-sans-first:1493.97 00:24:55 INFO - 2015-11-18 00:24:55,094 DEBUG : BROWSER_OUTPUT: Values: 272.2 278.0 281.4 281.7 283.8 5489.6 5598.0 5628.2 5641.2 5649.3 5438.8 5617.3 5645.5 5677.5 5691.7 4324.2 4333.1 4341.8 4346.3 4388.5 4124.3 4213.9 4226.2 4323.1 4330.4 4042.4 4192.7 4195.3 4235.0 4264.9 4257.0 4266.6 4275.5 4292.3 4305.2 3702.7 3709.7 3716.8 3720.3 3733.9 5262.5 5448.8 5471.8 5492.3 5493.9 4849.7 4880.5 4880.9 4886.1 4889.1 5896.7 5900.7 5909.0 5924.4 5990.4 4026.6 4035.6 4036.1 4050.1 4055.9 5910.1 6251.4 6253.6 6261.1 6262.8 4101.5 4107.4 4142.4 4152.4 4155.6 4197.7 4201.7 4210.5 4223.5 4233.2 4836.8 4839.6 4862.2 4871.6 4872.8 5762.7 5911.4 5948.8 5950.9 5959.2 1448.9 1478.4 1487.1 1488.6 1492.5 969.2 970.8 980.6 982.6 990.0 5722.2 5745.0 5749.9 5755.7 5755.9 5943.8 6180.0 6180.1 6201.5 6208.0 5557.5 5644.9 5702.5 5747.9 5803.8 3343.0 3354.6 3370.9 3377.2 3382.7 6430.1 6434.6 6445.6 6452.3 6454.5 6141.2 6360.4 6361.6 6384.4 6390.0 6417.6 6417.8 6424.6 6426.8 6440.3 6210.4 6221.8 6230.6 6247.5 6263.5 5885.7 5986.3 6031.5 6057.0 6116.7 6441.1 6453.4 6471.8 6484.4 6489.7 3997.6 4007.1 4026.9 4038.1 4057.4 6087.6 6199.5 6206.7 6222.7 6245.1 6005.7 6010.0 6041.8 6047.7 6061.8 6032.6 6032.7 6042.5 6043.4 6057.0 5686.4 5857.8 5875.2 5879.2 5902.1 6019.6 6043.2 6045.8 6063.6 6063.8 5913.8 5927.3 5944.7 5949.2 5949.4 00:24:55 INFO - 2015-11-18 00:24:55,094 DEBUG : BROWSER_OUTPUT: 00:24:55 INFO - 2015-11-18 00:24:55,094 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11788.75 Median:5664.94 stddev:14556.73 (257.0%) stddev-sans-first:14573.43 00:24:55 INFO - 2015-11-18 00:24:55,096 DEBUG : BROWSER_OUTPUT: Values: 627.8 669.3 679.3 703.7 704.5 12258.6 12755.0 12766.2 12803.6 12816.2 11647.7 11712.8 11758.2 11759.7 11811.3 622.9 632.2 784.9 789.6 812.4 775.9 781.0 786.7 787.4 795.6 824.2 824.5 824.5 833.0 834.0 645.4 655.7 811.8 826.8 828.8 620.3 620.3 620.7 625.6 625.7 12225.6 12319.2 12342.8 12401.7 12424.3 8387.8 8681.7 8713.1 10211.6 10975.6 7978.7 8063.4 8129.9 8160.0 8192.0 2583.3 2589.6 2685.7 2749.7 2753.0 39347.4 39703.0 39948.6 39985.0 40128.8 5934.6 5946.0 5994.6 6043.9 6155.8 10819.4 10903.7 10915.1 10944.3 10959.8 5438.5 5492.7 5528.8 5663.9 5665.9 3429.8 3486.7 3521.1 3618.1 3624.2 2426.1 2439.5 2445.5 2453.7 2459.9 345.2 346.0 346.2 347.3 350.5 502.0 518.2 531.3 559.0 565.0 6524.9 7289.2 7630.4 7783.1 7891.6 385.4 512.5 545.0 553.0 554.8 3341.7 3459.6 3589.5 3611.8 3741.0 53106.2 53377.5 53397.5 53426.2 53655.7 46362.5 47000.0 47135.8 47173.8 47584.0 41398.4 41856.2 41984.0 42214.2 43003.1 7420.2 7431.5 7454.2 7683.2 7803.9 30338.0 31344.0 31414.2 31457.5 31471.4 39251.4 41147.0 42130.0 42707.8 42768.0 6156.5 6333.5 6390.3 6580.6 6697.4 9445.4 9609.7 9731.6 9754.1 9947.8 8920.5 9043.8 9049.5 9055.3 9064.9 8740.0 8811.3 9015.7 9179.2 9186.2 9003.7 9051.4 9125.4 9285.2 9603.4 7829.0 7951.0 8025.5 8183.6 8568.4 7670.1 8082.9 8110.8 8143.3 8250.3 00:24:55 INFO - 2015-11-18 00:24:55,096 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:24:55 INFO - 2015-11-18 00:24:55,096 DEBUG : BROWSER_OUTPUT: 00:24:55 INFO - 2015-11-18 00:24:55,771 INFO : Browser exited with error code: 0 00:24:55 INFO - 2015-11-18 00:24:55,801 INFO : Completed test dromaeo_css (00:18:35) 00:24:55 INFO - 2015-11-18 00:24:55,802 INFO : Starting test kraken 00:24:55 INFO - 2015-11-18 00:24:55,802 DEBUG : operating with platform_type : mac_ 00:24:55 INFO - 2015-11-18 00:24:55,802 INFO : Initialising browser for kraken test... 00:24:55 INFO - 2015-11-18 00:24:55,816 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmpgIdPnw/profile http://localhost:49267/getInfo.html 00:24:58 INFO - 2015-11-18 00:24:58,241 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:24:58 INFO - 2015-11-18 00:24:58,241 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:24:58 INFO - 2015-11-18 00:24:58,241 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 00:24:58 INFO - 2015-11-18 00:24:58,241 DEBUG : BROWSER_OUTPUT: __metrics 00:24:58 INFO - 2015-11-18 00:24:58,257 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:24:59 INFO - 2015-11-18 00:24:59,012 INFO : Browser initialized. 00:24:59 INFO - 2015-11-18 00:24:59,012 INFO : Running cycle 1/1 for kraken test... 00:24:59 INFO - 2015-11-18 00:24:59,013 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmpgIdPnw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:25:11 INFO - 2015-11-18 00:25:11,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 229367808 00:25:11 INFO - 2015-11-18 00:25:11,052 DEBUG : BROWSER_OUTPUT: 00:25:13 INFO - 2015-11-18 00:25:13,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 00:25:14 INFO - 2015-11-18 00:25:14,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 285900800 00:25:14 INFO - 2015-11-18 00:25:14,380 DEBUG : BROWSER_OUTPUT: 00:25:17 INFO - 2015-11-18 00:25:17,263 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 00:25:17 INFO - 2015-11-18 00:25:17,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 299212800 00:25:17 INFO - 2015-11-18 00:25:17,848 DEBUG : BROWSER_OUTPUT: 00:25:21 INFO - 2015-11-18 00:25:21,070 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 00:25:21 INFO - 2015-11-18 00:25:21,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 282816512 00:25:21 INFO - 2015-11-18 00:25:21,647 DEBUG : BROWSER_OUTPUT: 00:25:23 INFO - 2015-11-18 00:25:23,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 00:25:24 INFO - 2015-11-18 00:25:24,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 285229056 00:25:24 INFO - 2015-11-18 00:25:24,391 DEBUG : BROWSER_OUTPUT: 00:25:26 INFO - 2015-11-18 00:25:26,737 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:25:27 INFO - 2015-11-18 00:25:27,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 284184576 00:25:27 INFO - 2015-11-18 00:25:27,320 DEBUG : BROWSER_OUTPUT: 00:25:30 INFO - 2015-11-18 00:25:30,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 00:25:31 INFO - 2015-11-18 00:25:31,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 284864512 00:25:31 INFO - 2015-11-18 00:25:31,243 DEBUG : BROWSER_OUTPUT: 00:25:34 INFO - 2015-11-18 00:25:34,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 00:25:35 INFO - 2015-11-18 00:25:35,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 285208576 00:25:35 INFO - 2015-11-18 00:25:35,254 DEBUG : BROWSER_OUTPUT: 00:25:38 INFO - 2015-11-18 00:25:38,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 00:25:38 INFO - 2015-11-18 00:25:38,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 284229632 00:25:38 INFO - 2015-11-18 00:25:38,931 DEBUG : BROWSER_OUTPUT: 00:25:40 INFO - 2015-11-18 00:25:40,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:25:41 INFO - 2015-11-18 00:25:41,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 318619648 00:25:41 INFO - 2015-11-18 00:25:41,212 DEBUG : BROWSER_OUTPUT: 00:25:43 INFO - 2015-11-18 00:25:43,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:25:43 INFO - 2015-11-18 00:25:43,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 319975424 00:25:43 INFO - 2015-11-18 00:25:43,817 DEBUG : BROWSER_OUTPUT: 00:25:46 INFO - 2015-11-18 00:25:46,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:25:46 INFO - 2015-11-18 00:25:46,679 DEBUG : BROWSER_OUTPUT: RSS: Main: 328261632 00:25:46 INFO - 2015-11-18 00:25:46,680 DEBUG : BROWSER_OUTPUT: 00:25:49 INFO - 2015-11-18 00:25:49,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:25:50 INFO - 2015-11-18 00:25:50,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 330137600 00:25:50 INFO - 2015-11-18 00:25:50,081 DEBUG : BROWSER_OUTPUT: 00:25:52 INFO - 2015-11-18 00:25:52,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:25:53 INFO - 2015-11-18 00:25:53,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 329170944 00:25:53 INFO - 2015-11-18 00:25:53,555 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 00:25:55 INFO - 2015-11-18 00:25:55,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 388743168 00:25:55 INFO - 2015-11-18 00:25:55,675 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,677 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:25:55 INFO - 2015-11-18 00:25:55,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:25:55 INFO - 2015-11-18 00:25:55,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:25:55 INFO - 2015-11-18 00:25:55,677 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:25:55 INFO - 2015-11-18 00:25:55,677 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;115;114;120;122;122;121;120;113;119 00:25:55 INFO - 2015-11-18 00:25:55,677 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;172;145;169;189;146;168;166;140;182;143 00:25:55 INFO - 2015-11-18 00:25:55,677 DEBUG : BROWSER_OUTPUT: |2;audio-dft;180;179;179;183;182;178;179;180;181;180 00:25:55 INFO - 2015-11-18 00:25:55,677 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;85;98;99;79;78;79;89;92;75 00:25:55 INFO - 2015-11-18 00:25:55,677 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;107;111;149;99;100;100;139;98;99;142 00:25:55 INFO - 2015-11-18 00:25:55,678 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;136;135;129;135;138;135;135;129;129;135 00:25:55 INFO - 2015-11-18 00:25:55,678 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;141;141;141;141;141;150;141;142;141;141 00:25:55 INFO - 2015-11-18 00:25:55,678 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;110;105;109;117;104;113;113;119;115;105 00:25:55 INFO - 2015-11-18 00:25:55,678 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;66;67;67;68;67;67;68;77;70;70 00:25:55 INFO - 2015-11-18 00:25:55,678 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;73;77;77;79;80;79;81;79;79;79 00:25:55 INFO - 2015-11-18 00:25:55,678 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;92;96;96;100;100;97;96;98;99;101 00:25:55 INFO - 2015-11-18 00:25:55,678 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;143;145;148;133;142;140;141;139;145;151 00:25:55 INFO - 2015-11-18 00:25:55,678 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;176;165;176;175;176;174;174;175;174;166 00:25:55 INFO - 2015-11-18 00:25:55,679 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;76;81;80;79;80;79;80;81;87;84 00:25:55 INFO - 2015-11-18 00:25:55,679 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:25:55 INFO - 2015-11-18 00:25:55,679 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:25:55 INFO - 2015-11-18 00:25:55,679 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,938 00:25:55 INFO - 2015-11-18 00:25:55,679 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:25:55 INFO - 2015-11-18 00:25:55,679 DEBUG : BROWSER_OUTPUT: __startTimestamp1447835155675__endTimestamp 00:25:55 INFO - 2015-11-18 00:25:55,679 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,681 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:25:55 INFO - 2015-11-18 00:25:55,681 DEBUG : BROWSER_OUTPUT: Number of tests: 14 00:25:55 INFO - 2015-11-18 00:25:55,681 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,681 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:117.70 Median:120.00 stddev:4.06 (3.4%) stddev-sans-first:3.50 00:25:55 INFO - 2015-11-18 00:25:55,681 DEBUG : BROWSER_OUTPUT: Values: 111.0 115.0 114.0 120.0 122.0 122.0 121.0 120.0 113.0 119.0 00:25:55 INFO - 2015-11-18 00:25:55,682 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,682 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:162.00 Median:168.50 stddev:17.38 (10.3%) stddev-sans-first:18.06 00:25:55 INFO - 2015-11-18 00:25:55,682 DEBUG : BROWSER_OUTPUT: Values: 172.0 145.0 169.0 189.0 146.0 168.0 166.0 140.0 182.0 143.0 00:25:55 INFO - 2015-11-18 00:25:55,682 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,682 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:180.10 Median:180.00 stddev:1.52 (0.8%) stddev-sans-first:1.62 00:25:55 INFO - 2015-11-18 00:25:55,682 DEBUG : BROWSER_OUTPUT: Values: 180.0 179.0 179.0 183.0 182.0 178.0 179.0 180.0 181.0 180.0 00:25:55 INFO - 2015-11-18 00:25:55,682 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,683 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:85.80 Median:87.00 stddev:8.47 (9.7%) stddev-sans-first:8.96 00:25:55 INFO - 2015-11-18 00:25:55,683 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 98.0 99.0 79.0 78.0 79.0 89.0 92.0 75.0 00:25:55 INFO - 2015-11-18 00:25:55,683 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,683 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:114.40 Median:145.50 stddev:20.52 (14.1%) stddev-sans-first:21.59 00:25:55 INFO - 2015-11-18 00:25:55,683 DEBUG : BROWSER_OUTPUT: Values: 107.0 111.0 149.0 99.0 100.0 100.0 139.0 98.0 99.0 142.0 00:25:55 INFO - 2015-11-18 00:25:55,684 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,684 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:133.60 Median:135.00 stddev:3.31 (2.4%) stddev-sans-first:3.39 00:25:55 INFO - 2015-11-18 00:25:55,684 DEBUG : BROWSER_OUTPUT: Values: 136.0 135.0 129.0 135.0 138.0 135.0 135.0 129.0 129.0 135.0 00:25:55 INFO - 2015-11-18 00:25:55,684 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,684 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:142.00 Median:141.00 stddev:2.83 (2.0%) stddev-sans-first:2.98 00:25:55 INFO - 2015-11-18 00:25:55,684 DEBUG : BROWSER_OUTPUT: Values: 141.0 141.0 141.0 141.0 141.0 150.0 141.0 142.0 141.0 141.0 00:25:55 INFO - 2015-11-18 00:25:55,684 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,686 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:111.00 Median:113.00 stddev:5.27 (4.7%) stddev-sans-first:5.58 00:25:55 INFO - 2015-11-18 00:25:55,686 DEBUG : BROWSER_OUTPUT: Values: 110.0 105.0 109.0 117.0 104.0 113.0 113.0 119.0 115.0 105.0 00:25:55 INFO - 2015-11-18 00:25:55,686 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,686 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.70 Median:68.00 stddev:3.20 (4.7%) stddev-sans-first:3.24 00:25:55 INFO - 2015-11-18 00:25:55,686 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 67.0 68.0 67.0 67.0 68.0 77.0 70.0 70.0 00:25:55 INFO - 2015-11-18 00:25:55,687 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,687 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:78.30 Median:79.00 stddev:2.21 (2.8%) stddev-sans-first:1.27 00:25:55 INFO - 2015-11-18 00:25:55,687 DEBUG : BROWSER_OUTPUT: Values: 73.0 77.0 77.0 79.0 80.0 79.0 81.0 79.0 79.0 79.0 00:25:55 INFO - 2015-11-18 00:25:55,687 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,687 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:97.50 Median:96.00 stddev:2.68 (2.8%) stddev-sans-first:1.96 00:25:55 INFO - 2015-11-18 00:25:55,687 DEBUG : BROWSER_OUTPUT: Values: 92.0 96.0 96.0 100.0 100.0 97.0 96.0 98.0 99.0 101.0 00:25:55 INFO - 2015-11-18 00:25:55,687 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,687 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:144.00 stddev:5.01 (3.5%) stddev-sans-first:5.32 00:25:55 INFO - 2015-11-18 00:25:55,687 DEBUG : BROWSER_OUTPUT: Values: 143.0 145.0 148.0 133.0 142.0 140.0 141.0 139.0 145.0 151.0 00:25:55 INFO - 2015-11-18 00:25:55,687 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,688 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:175.00 stddev:4.09 (2.3%) stddev-sans-first:4.21 00:25:55 INFO - 2015-11-18 00:25:55,688 DEBUG : BROWSER_OUTPUT: Values: 176.0 165.0 176.0 175.0 176.0 174.0 174.0 175.0 174.0 166.0 00:25:55 INFO - 2015-11-18 00:25:55,688 DEBUG : BROWSER_OUTPUT: 00:25:55 INFO - 2015-11-18 00:25:55,688 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.70 Median:80.50 stddev:2.98 (3.7%) stddev-sans-first:2.64 00:25:55 INFO - 2015-11-18 00:25:55,688 DEBUG : BROWSER_OUTPUT: Values: 76.0 81.0 80.0 79.0 80.0 79.0 80.0 81.0 87.0 84.0 00:25:55 INFO - 2015-11-18 00:25:55,688 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:25:55 INFO - 2015-11-18 00:25:55,688 DEBUG : BROWSER_OUTPUT: 00:25:56 INFO - 2015-11-18 00:25:56,388 INFO : Browser exited with error code: 0 00:25:56 INFO - 2015-11-18 00:25:56,440 INFO : Completed test kraken (00:01:00) 00:25:56 INFO - 2015-11-18 00:25:56,441 INFO : Starting test v8_7 00:25:56 INFO - 2015-11-18 00:25:56,441 DEBUG : operating with platform_type : mac_ 00:25:56 INFO - 2015-11-18 00:25:56,441 INFO : Initialising browser for v8_7 test... 00:25:56 INFO - 2015-11-18 00:25:56,455 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmpbaj_J_/profile http://localhost:49267/getInfo.html 00:25:58 INFO - 2015-11-18 00:25:58,805 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:25:58 INFO - 2015-11-18 00:25:58,805 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:25:58 INFO - 2015-11-18 00:25:58,805 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 00:25:58 INFO - 2015-11-18 00:25:58,805 DEBUG : BROWSER_OUTPUT: __metrics 00:25:58 INFO - 2015-11-18 00:25:58,821 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:25:59 INFO - 2015-11-18 00:25:59,581 INFO : Browser initialized. 00:25:59 INFO - 2015-11-18 00:25:59,581 INFO : Running cycle 1/1 for v8_7 test... 00:25:59 INFO - 2015-11-18 00:25:59,581 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/T/tmpbaj_J_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:26:11 INFO - 2015-11-18 00:26:11,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 228765696 00:26:11 INFO - 2015-11-18 00:26:11,630 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49267/tests/v8_7/run.html (next: http://localhost:49267/tests/v8_7/run.html) 00:26:34 INFO - 2015-11-18 00:26:34,714 DEBUG : BROWSER_OUTPUT: RSS: Main: 703311872 00:26:34 INFO - 2015-11-18 00:26:34,714 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,714 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:26:34 INFO - 2015-11-18 00:26:34,714 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:26:34 INFO - 2015-11-18 00:26:34,714 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:26:34 INFO - 2015-11-18 00:26:34,714 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:26:34 INFO - 2015-11-18 00:26:34,714 DEBUG : BROWSER_OUTPUT: |0;Richards;185.01387604070305 00:26:34 INFO - 2015-11-18 00:26:34,715 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;213.85799828913602 00:26:34 INFO - 2015-11-18 00:26:34,715 DEBUG : BROWSER_OUTPUT: |2;Encrypt;358.03795202291445 00:26:34 INFO - 2015-11-18 00:26:34,715 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6211.180124223602 00:26:34 INFO - 2015-11-18 00:26:34,715 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2239.373601789709 00:26:34 INFO - 2015-11-18 00:26:34,715 DEBUG : BROWSER_OUTPUT: |5;Earley;996.01593625498 00:26:34 INFO - 2015-11-18 00:26:34,715 DEBUG : BROWSER_OUTPUT: |6;Boyer;14211.267605633802 00:26:34 INFO - 2015-11-18 00:26:34,716 DEBUG : BROWSER_OUTPUT: |7;RegExp;32370.967741935485 00:26:34 INFO - 2015-11-18 00:26:34,716 DEBUG : BROWSER_OUTPUT: |8;Splay;906.6183136899365 00:26:34 INFO - 2015-11-18 00:26:34,716 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6477.419354838709 00:26:34 INFO - 2015-11-18 00:26:34,716 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:26:34 INFO - 2015-11-18 00:26:34,716 DEBUG : BROWSER_OUTPUT: __startTimestamp1447835194713__endTimestamp 00:26:34 INFO - 2015-11-18 00:26:34,717 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,717 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:26:34 INFO - 2015-11-18 00:26:34,717 DEBUG : BROWSER_OUTPUT: Number of tests: 10 00:26:34 INFO - 2015-11-18 00:26:34,717 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,717 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:185.01 Median:185.01 stddev:0.00 (0.0%) 00:26:34 INFO - 2015-11-18 00:26:34,718 DEBUG : BROWSER_OUTPUT: Values: 185.0 00:26:34 INFO - 2015-11-18 00:26:34,718 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,718 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:213.86 Median:213.86 stddev:0.00 (0.0%) 00:26:34 INFO - 2015-11-18 00:26:34,718 DEBUG : BROWSER_OUTPUT: Values: 213.9 00:26:34 INFO - 2015-11-18 00:26:34,718 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,718 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:358.04 Median:358.04 stddev:0.00 (0.0%) 00:26:34 INFO - 2015-11-18 00:26:34,718 DEBUG : BROWSER_OUTPUT: Values: 358.0 00:26:34 INFO - 2015-11-18 00:26:34,719 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,719 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6211.18 Median:6211.18 stddev:0.00 (0.0%) 00:26:34 INFO - 2015-11-18 00:26:34,719 DEBUG : BROWSER_OUTPUT: Values: 6211.2 00:26:34 INFO - 2015-11-18 00:26:34,719 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,719 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2239.37 Median:2239.37 stddev:0.00 (0.0%) 00:26:34 INFO - 2015-11-18 00:26:34,721 DEBUG : BROWSER_OUTPUT: Values: 2239.4 00:26:34 INFO - 2015-11-18 00:26:34,721 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,721 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:996.02 Median:996.02 stddev:0.00 (0.0%) 00:26:34 INFO - 2015-11-18 00:26:34,721 DEBUG : BROWSER_OUTPUT: Values: 996.0 00:26:34 INFO - 2015-11-18 00:26:34,721 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,721 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:14211.27 Median:14211.27 stddev:0.00 (0.0%) 00:26:34 INFO - 2015-11-18 00:26:34,721 DEBUG : BROWSER_OUTPUT: Values: 14211.3 00:26:34 INFO - 2015-11-18 00:26:34,721 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,721 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:32370.97 Median:32370.97 stddev:0.00 (0.0%) 00:26:34 INFO - 2015-11-18 00:26:34,722 DEBUG : BROWSER_OUTPUT: Values: 32371.0 00:26:34 INFO - 2015-11-18 00:26:34,722 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,722 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:906.62 Median:906.62 stddev:0.00 (0.0%) 00:26:34 INFO - 2015-11-18 00:26:34,722 DEBUG : BROWSER_OUTPUT: Values: 906.6 00:26:34 INFO - 2015-11-18 00:26:34,722 DEBUG : BROWSER_OUTPUT: 00:26:34 INFO - 2015-11-18 00:26:34,722 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6477.42 Median:6477.42 stddev:0.00 (0.0%) 00:26:34 INFO - 2015-11-18 00:26:34,722 DEBUG : BROWSER_OUTPUT: Values: 6477.4 00:26:34 INFO - 2015-11-18 00:26:34,722 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:26:34 INFO - 2015-11-18 00:26:34,723 DEBUG : BROWSER_OUTPUT: 00:26:35 INFO - 2015-11-18 00:26:35,429 INFO : Browser exited with error code: 0 00:26:35 INFO - 2015-11-18 00:26:35,451 INFO : Completed test v8_7 (00:00:39) 00:26:35 INFO - 2015-11-18 00:26:35,504 INFO : Completed test suite (00:20:15) 00:26:35 INFO - 2015-11-18 00:26:35,505 DEBUG : Working with test: dromaeo_css 00:26:35 INFO - 2015-11-18 00:26:35,505 DEBUG : Generating results file: dromaeo_css 00:26:35 INFO - 2015-11-18 00:26:35,506 DEBUG : Working with test: kraken 00:26:35 INFO - 2015-11-18 00:26:35,506 DEBUG : Generating results file: kraken 00:26:35 INFO - 2015-11-18 00:26:35,506 INFO : javascript benchmark 00:26:35 INFO - 2015-11-18 00:26:35,506 DEBUG : Working with test: v8_7 00:26:35 INFO - 2015-11-18 00:26:35,507 DEBUG : Generating results file: v8_7 00:26:35 INFO - 2015-11-18 00:26:35,507 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:26:35 INFO - 2015-11-18 00:26:35,563 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 00:26:35 INFO - 2015-11-18 00:26:35,563 DEBUG : process_Request line: dromaeo_css 5875.66 graph.html#tests=[[72,64,55]] 00:26:35 INFO - 2015-11-18 00:26:35,563 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:26:35 INFO - 2015-11-18 00:26:35,593 DEBUG : process_Request line: kraken 1687.60 graph.html#tests=[[232,64,55]] 00:26:35 INFO - 2015-11-18 00:26:35,594 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:26:35 INFO - 2015-11-18 00:26:35,621 DEBUG : process_Request line: v8_7 16118.56 graph.html#tests=[[230,64,55]] 00:26:35 INFO - 2015-11-18 00:26:35,622 INFO : javascript benchmark 00:26:35 INFO - 2015-11-18 00:26:35,624 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [297.1338548132195, 298.7132352941176, 303.3356948283258, 303.64473565927864, 307.44352721573944, 15529.456469023586, 15851.68296634068, 15955.920220398897, 16505.33978640856, 16549.751753723674, 10145.0, 10479.004494573022, 10581.78836423271, 10592.152627789777, 15857.20713964303, 3896.7272290939645, 3941.7043721720916, 4099.487564054493, 4282.807273672693, 4373.059792144688, 3524.559430071241, 4375.540568240337, 4378.956210437903, 4400.845970391037, 4416.690831641787, 3055.3278278778744, 3130.514770210621, 3138.686131386866, 4309.956900430987, 4353.804078816461, 4230.873073807776, 4303.246931786956, 4359.760213188273, 4375.9562404375865, 4404.471463424394, 3678.062094165997, 3683.189698266377, 3694.5751238607636, 3695.63043695631, 3710.07248187953, 10055.849162262572, 10370.118539924115, 10378.06597406237, 11614.303141811433, 11621.47703353351, 1572.3553343129263, 1625.5692241555996, 1628.696745576785, 1666.0253751555354, 1692.6022384739576, 8581.570921453902, 8612.784680382978, 8731.432456890281, 8756.956215218883, 9006.369554131148, 1347.9258640774754, 1406.3319923036477, 1406.4725727852056, 1471.8896082793833, 1501.06183635228, 49648.0, 50865.0, 51735.48264517344, 52019.47980520222, 52255.73872130653, 5805.0, 5810.273715785527, 5832.679202643811, 5900.527957763368, 5903.645781253139, 6694.430973367221, 6696.096027036385, 6708.664566771642, 6740.528163028541, 6752.62860542665, 4747.145513807548, 4776.379070720854, 4790.257510085942, 4790.784414701347, 4821.397325334333, 4883.389576302962, 4887.706737595756, 4928.507149285043, 4936.703797772145, 5031.069252188357, 2656.123479251842, 2665.586834040727, 2665.853378064225, 2677.303900985719, 2685.78513718902, 929.6142101027998, 931.4318265857821, 933.244072301438, 942.34036174678, 1004.3120462483222, 379.91072098056935, 380.1560535610939, 420.30439622424933, 423.91097869447145, 424.72392944585647, 10228.33515821484, 10302.124319432782, 10638.893611063944, 10822.134229261641, 10834.783304333869, 378.1623703496713, 387.0065046862516, 388.47361824727653, 409.17142785858874, 425.0478927203043, 5603.607747457639, 5611.158326251013, 5675.148727690879, 5693.345265294462, 5755.913661295084, 426784.0, 427876.0, 429038.0, 440208.0, 445532.0, 48487.0, 49225.34161490683, 65154.674226628566, 65950.0, 65975.34024659693, 451.3906226594072, 451.97740112994876, 453.7050916903973, 456.30641425033764, 457.26608792886935, 9813.509324533887, 9912.900870991198, 9946.502674866084, 10036.64871729486, 10096.0, 31499.37001259916, 31552.842235788674, 31649.0, 32025.519617205293, 32820.83589582037, 41490.37764433596, 42610.78694606507, 43729.78135109304, 43747.56252437562, 43804.0, 5507.752151153128, 5655.462731040545, 5661.688607126647, 5670.376258611632, 5683.204351390726, 10388.0, 10654.254202205771, 10746.623868164577, 10774.0, 10832.295900766425, 8937.73186804397, 8969.416987895765, 9286.582103805209, 9361.578728957349, 9449.102335278138, 8937.687180948635, 8961.283097352065, 9020.774480638036, 9046.457212567268, 9329.533523323942, 7517.924820751722, 8833.469991800512, 9303.441793492411, 9387.15515603599, 9387.389819661701, 5524.8342549723575, 5535.197396377423, 5584.0, 5599.0, 5622.353429355677, 4210.7473551587, 9171.63313467454, 9223.953880230825, 9301.581428835583, 9414.529273536433], "dojo.html": [2758.144975057732, 2875.5111631022723, 2891.696371880953, 2896.797224194307, 2909.2726818295414, 4674.85975420737, 4734.526547345264, 4772.260299653555, 4855.247436647316, 4910.729909854961, 4822.6624136310475, 4822.855314340575, 4854.223324268127, 4952.05910876934, 4973.104841128605, 4429.114177164563, 4433.866983990485, 4465.8660240192685, 4507.887302817439, 4527.411436513249, 4480.171168333853, 4521.502634710179, 4540.160070386973, 4600.401947746805, 4612.400387949562, 4279.614834664895, 4351.6518678505645, 4390.385346051556, 4509.301058335946, 4547.045120524694, 4484.1031793641405, 4488.640908727294, 4532.274836026253, 4537.342085397599, 4542.04617030424, 4457.442819647544, 4470.664700147469, 4477.126960242754, 4513.684042117053, 4560.429946256718, 4659.138059459011, 4757.333973243749, 4826.975865120687, 4847.054824309261, 4906.582940450066, 5142.485751424865, 5142.845714628567, 5163.664361816507, 5202.713850738208, 5205.713685747282, 5216.087184742655, 5228.607854410934, 5251.0, 5269.262303277545, 5320.467953204688, 4568.931466027979, 4713.717176969324, 4730.432348118248, 4741.620670346364, 4796.424429068499, 5279.366476022902, 5321.733913304397, 5325.467453254643, 5351.545118664879, 5358.30342055538, 5038.84883453497, 5065.493450654905, 5067.974660126676, 5109.744512774347, 5110.744462776846, 5055.51972562606, 5062.9746851266245, 5139.331886854685, 5184.351956005499, 5224.738763061908, 5128.1282182029145, 5133.153029750124, 5164.32863727713, 5174.715390653475, 5186.377634683862, 5128.871778205575, 5132.897342053213, 5141.434442211354, 5163.561097306771, 5207.817726379559, 3814.5803961564206, 3889.202713443737, 3891.455196272524, 3928.744631598937, 3961.465202197724, 3588.6949609282983, 3604.873829415958, 3646.927061458756, 3684.907877303035, 3716.1452865840465, 4876.463589005207, 4888.315635810989, 4918.643646751956, 4927.43334516528, 4929.926051109236, 5043.949560504348, 5116.283720279164, 5167.250748641502, 5225.764840582183, 5229.895402091937, 4780.617550595944, 4820.180569303227, 4832.251001094836, 4856.562909338177, 4941.061198372297, 4594.471635761864, 4599.195140850338, 4631.467381251132, 4641.234196357631, 4697.13103075932, 5243.056249875059, 5338.386085600206, 5376.435474275301, 5420.7289635518855, 5424.376196737347, 5110.66780659256, 5157.200633901752, 5157.716325602128, 5179.067767801832, 5194.818181363634, 5354.919676204782, 5408.13469844823, 5411.675299482044, 5413.323334583177, 5428.647137936022, 4945.431275403231, 5003.324551185543, 5066.265391518283, 5161.0968080585, 5162.483751624807, 5026.974865125651, 5083.898322033612, 5109.8978020438635, 5143.125668636266, 5158.509941555546, 5040.873978150576, 5058.215976523645, 5077.644315798436, 5085.3134826797905, 5087.3386459759995, 4878.170710979071, 5032.245163225399, 5037.899242015213, 5060.3927528696795, 5082.872928176826, 4840.515948405131, 4917.26241063829, 4955.603551715926, 4960.925586116284, 4968.900621987467, 5053.8736531587, 5095.490450954875, 5102.744862756773, 5108.56577190943, 5121.487851214849, 4799.256115302133, 4942.703437793743, 4950.430700469348, 4972.5027497249985, 4972.801087956441], "mootools.html": [1446.1034158821533, 1518.3167574591432, 1577.1246957938347, 1615.3054186699715, 1619.7408414653655, 5783.624064435809, 5978.282606087265, 6070.484008859246, 6526.28210896801, 6577.276499585042, 6112.908306375408, 6158.384161583839, 6163.784267550625, 6404.23149222094, 6664.333566643345, 1922.1062206074173, 1926.412444204517, 1968.6358023765576, 1972.1914015253749, 1976.3873199308262, 1744.4504980930967, 1972.4181366496846, 1980.6236815005175, 2018.5357367805414, 2052.9794702053014, 1744.8571185873209, 1919.5489060070872, 1943.5335519475295, 1950.161430584848, 1964.9803501965011, 1883.3878989328523, 1915.5306949797318, 1922.8942408167545, 1924.7401600783855, 1940.0978544976654, 1982.0684278389133, 2017.7074324223051, 2021.1410150686047, 2035.0943829995658, 2038.449618602969, 6532.706028228741, 6590.967045164792, 6648.202215734094, 6669.866602667919, 6674.0, 4059.4925634295714, 4146.170765846843, 4156.750594964282, 4176.686748493845, 4180.602842729936, 2537.6827896512937, 2589.585666293384, 2592.7925765938867, 2599.8050146239107, 2601.258641287243, 794.3208556684067, 803.2890891560952, 831.7837362285788, 835.2274146414603, 839.8698201778734, 8735.737927862174, 8792.296616270747, 8823.382363234576, 8825.867611985761, 8830.42602230853, 3629.165291982859, 3705.8517659293866, 3809.5238095238096, 3809.8476060957805, 3820.2359528094494, 7634.580098094658, 7642.961785191039, 7681.0782706074515, 7687.346575541142, 7692.46152769312, 4236.301010333261, 4242.300020496584, 4261.2542805009, 4290.849820256276, 4295.055087880662, 3826.215625796705, 3855.63371479709, 3890.980545097313, 3897.142628621755, 3905.941410878839, 3083.1699525283457, 3149.3228955774616, 3151.2437015116666, 3157.3053928135773, 3176.0630613968933, 974.0892265731422, 1027.7944411117805, 1038.0346277961416, 1040.4225654761528, 1050.9211809114347, 785.4658831994185, 791.2087912087912, 793.6031984007996, 843.2242337049929, 995.8290925781721, 5742.310922689304, 6267.843303917439, 6290.591111577733, 6343.492520598341, 6375.840603984938, 980.1668581705636, 1013.964511242103, 1019.0, 1029.9279050466396, 1043.7181960870523, 4750.192467280502, 4924.1875090610365, 4959.280904268933, 4985.750712464434, 5004.049230646166, 7524.586147761816, 7668.041494813148, 7814.882776758353, 7817.57003364809, 7835.882461763078, 7667.118281397599, 7694.846103077907, 7703.075630924325, 7725.652345644459, 7768.145503994556, 6216.782412615627, 6252.968735156295, 6253.74985000604, 6263.342349053284, 6277.403646653561, 5942.168096466412, 6024.8795024100145, 6032.034874420072, 6098.146259523582, 6106.3588323227195, 6743.966280168568, 6931.757388491378, 6980.092587963735, 7009.2990700929495, 7036.050133231948, 6973.686184121625, 7185.820354491179, 7203.063601731951, 7252.4560657949805, 7274.8908766369605, 5756.366799651951, 5839.503642190291, 5857.414258574108, 5860.2967643883, 5883.294004719461, 6357.8728425432155, 6358.300586935341, 6412.03819427071, 6423.96788016057, 6439.710213040518, 5849.912251316318, 5999.790007349722, 6051.3948605140895, 6059.484943779652, 6092.299385570539, 5038.874028149179, 5861.648301101947, 5920.526357891445, 5932.584719069796, 5946.048632218824, 5977.9402205977385, 5981.132735753378, 5992.250968628921, 5997.13041608973, 6038.879222415615, 5290.074237008431, 5298.258243845788, 5311.41574426805, 5348.090824559912, 5354.437784032621, 5452.700101494456, 5552.7223638818705, 5593.161025846156, 5606.074997625346, 5631.859203519781], "ext.html": [502.2315856739189, 513.0175713508634, 513.3993227923329, 521.7208793295588, 537.2961420539092, 28104.437911241763, 28658.42683146336, 28683.713162868364, 34513.30973380531, 35071.649283507155, 38281.83195268638, 38460.80769596155, 38738.22523549527, 38790.612093879055, 38837.80581097091, 8070.233327833861, 8265.338772898183, 8301.584920753969, 8346.791330216764, 8363.372747043966, 7590.886136707926, 7819.100803407596, 9850.408975461496, 10134.0, 10154.0, 9800.90199098007, 9960.05379488951, 9990.700278991642, 10030.598776048986, 10041.949790251076, 7524.360429363511, 7747.302742753123, 9906.851397229048, 9929.453880036668, 9942.900570994307, 9837.704868853945, 10019.44893030883, 10024.348417352921, 10033.949830250802, 10132.54403551842, 35453.0, 35658.64341356579, 35733.0, 35791.64208357909, 35887.4616880747, 2697.892084316625, 2706.039356028601, 2779.4580056888913, 2810.395764910554, 3155.5108958111527, 24973.875130624412, 24984.875075624688, 25271.36821579457, 25426.491470170495, 26016.869915650488, 2109.314472796347, 2115.0482282972725, 2128.138104067855, 2143.764185939561, 2293.0598454633687, 230242.0, 232186.0, 232213.0, 232899.0, 233337.83331083404, 46900.2964955526, 47806.0, 48001.71981082078, 53464.0, 54206.45793542093, 60434.0, 62371.0, 62500.374996250364, 62526.68736656378, 62619.6869015652, 14968.550943471495, 14972.925135374253, 15145.0, 15148.242587870562, 15288.617784555252, 11403.315801051964, 11473.598424055119, 11474.827877581843, 11478.426078696031, 11493.712657183638, 17554.473365799047, 17752.644947100987, 17905.820941790676, 17945.461636150936, 17983.1008449577, 7638.197989211053, 7858.646360913658, 7867.0, 7924.881126783102, 7943.682252709942, 827.1893544326593, 847.563504795031, 861.9569021548898, 887.272436601993, 931.8602209668468, 23581.88209058944, 23759.406014849767, 24534.754652453605, 24582.50834983326, 24750.752492474843, 906.6509393883271, 963.2823546457934, 1016.1210552871713, 1026.9832865463138, 1064.3720205079042, 12779.552715654907, 12827.294498802656, 12925.806112908314, 12966.546170883974, 12969.935150324189, 253414.0, 255633.0, 258786.0, 259823.0, 260289.0, 47381.0, 47540.28689569659, 47594.5240547597, 47737.522624774, 47864.5213547867, 1269.8920591749804, 1278.5397256987478, 1289.3810970733912, 1304.1197191895433, 1305.1842598376015, 24162.154324598556, 24538.263852084467, 24550.754492455562, 24609.753902460747, 24790.628140578265, 41374.82814648169, 41460.58539414567, 41465.58534414617, 41657.58342416537, 41775.37336940009, 245449.0, 246730.0, 246784.0, 247477.0, 248218.0, 25056.37359066038, 25466.745332546438, 27479.0, 28621.856890715415, 28894.7110528892, 34104.0, 34801.82599086988, 34885.82557087198, 35172.29655406826, 35425.0, 28936.42127157403, 30156.09531714052, 30168.396632067674, 30255.69744302529, 30340.84829575838, 27537.0, 31413.214669633442, 31801.68198317987, 31875.52186717155, 32063.0, 30455.543166852072, 30630.540541892336, 31115.68884311128, 31126.221844453165, 31171.53242701316, 26619.20142395731, 27817.304567385978, 27855.582166267115, 27969.300767480974, 28063.43873122567, 21590.676139858228, 21676.34970950874, 21678.24126155577, 21720.456988575414, 21792.564148717254], "prototype.html": [272.15902860162095, 277.9583062540617, 281.41887003338115, 281.65778579026494, 283.7517172474086, 5489.560835133189, 5597.972010139943, 5628.183913332569, 5641.18202860585, 5649.293838270216, 5438.755256013479, 5617.325920889499, 5645.5483561315095, 5677.48902598766, 5691.715414229282, 4324.243257429937, 4333.068390296085, 4341.826326946918, 4346.282863327548, 4388.451443569554, 4124.298869192229, 4213.873583792491, 4226.218149642311, 4323.113761678848, 4330.437043184382, 4042.4138499917494, 4192.706510544263, 4195.328747400416, 4234.978825105885, 4264.872053838374, 4256.9574304257185, 4266.552012038722, 4275.465566804134, 4292.334688123346, 4305.182015417076, 3702.740808143431, 3709.666130048309, 3716.7955762433057, 3720.274546463441, 3733.906652333686, 5262.526372626482, 5448.782048718046, 5471.8084867029465, 5492.286002819608, 5493.890122197534, 4849.733264670442, 4880.487548807395, 4880.902381952376, 4886.071646387175, 4889.071076495455, 5896.734646940898, 5900.704964751788, 5908.97045514774, 5924.437178468082, 5990.371011043821, 4026.5570787213383, 4035.556088830226, 4036.112055347848, 4050.129222217208, 4055.898602534931, 5910.08393698973, 6251.374862513758, 6253.562250642457, 6261.092141639437, 6262.780802671885, 4101.487314085739, 4107.404426358161, 4142.440770496005, 4152.418661387408, 4155.646770024521, 4197.706160568792, 4201.68487363449, 4210.473690788652, 4223.493180818322, 4233.195692818416, 4836.782344794493, 4839.637027222972, 4862.222044472867, 4871.634627402959, 4872.756362181947, 5762.732198916232, 5911.408859114054, 5948.821535353946, 5950.9107363389585, 5959.165716799652, 1448.8840892728556, 1478.4381934864682, 1487.1077353587762, 1488.5608745420127, 1492.514932646894, 969.1519920069939, 970.7767213540925, 980.6371642492323, 982.5676702250987, 989.980200395988, 5722.227499287626, 5744.971275143681, 5749.8562535936935, 5755.65466072037, 5755.913661295084, 5943.791967281124, 6180.0, 6180.072989051679, 6201.534884883652, 6208.037754148114, 5557.499825015768, 5644.915326270109, 5702.54379649627, 5747.85630359236, 5803.82588522345, 3343.030521148888, 3354.5974483062187, 3370.915727106842, 3377.206356506219, 3382.729381649462, 6430.131932189094, 6434.581752186093, 6445.613263204223, 6452.322506136882, 6454.515911306671, 6141.232345956755, 6360.427561519486, 6361.5546911716665, 6384.3934826191435, 6389.9552143313695, 6417.582857114273, 6417.775377861846, 6424.614523128721, 6426.839329016812, 6440.291567927524, 6210.4100110489435, 6221.813345599639, 6230.563860529719, 6247.468965137832, 6263.467605253604, 5885.705714714161, 5986.341502434641, 6031.517478601789, 6057.030875059969, 6116.724747386289, 6441.066045423481, 6453.386928241997, 6471.7734879279, 6484.41131922682, 6489.707963141575, 3997.600239975979, 4007.0984028593334, 4026.879193624196, 4038.051058001426, 4057.3711074783455, 6087.604305720114, 6199.535034872493, 6206.658633775186, 6222.719977601109, 6245.094461303176, 6005.669688167192, 6009.969950150221, 6041.848953776191, 6047.697615119138, 6061.848453788691, 6032.638041717511, 6032.698365081641, 6042.546808989256, 6043.395660433922, 6057.0, 5686.402927692533, 5857.765689372548, 5875.20684707559, 5879.176915231786, 5902.1146827976145, 6019.638821670714, 6043.214382130295, 6045.758169673164, 6063.636181829104, 6063.818085457443, 5913.822585322448, 5927.31835838884, 5944.6730429826775, 5949.2266005419015, 5949.405059494016], "yui.html": [627.8399008252895, 669.3373560175427, 679.3274658088491, 703.6622421237803, 704.5314865614366, 12258.632241032772, 12755.043371747133, 12766.234025958438, 12803.615891523257, 12816.23102613844, 11647.708807279821, 11712.824307635392, 11758.23571467854, 11759.7060073498, 11811.291322520654, 622.8909940760349, 632.2034236861565, 784.8783438567003, 789.6170357376682, 812.4069429316603, 775.8681024225867, 780.9726659566917, 786.7167819584945, 787.4330482052912, 795.5624406576388, 824.2375802382802, 824.47233770387, 824.4846970643348, 832.9541875196862, 834.0408530190269, 645.3514218210692, 655.6590572902088, 811.8011087283594, 826.8139668574582, 828.8052307707684, 620.2587907450599, 620.2897682153908, 620.736187120472, 625.5871125057486, 625.7465726380777, 12225.572104976372, 12319.199252048587, 12342.75314493714, 12401.689957751038, 12424.254544727346, 8387.790305242357, 8681.696140635111, 8713.085126061736, 10211.642592509226, 10975.560977560888, 7978.720744773905, 8063.435559510778, 8129.918700813035, 8160.0, 8191.959040204761, 2583.302508322742, 2589.6245044468633, 2685.691145518271, 2749.738774816389, 2752.981396883166, 39347.40978885319, 39703.0, 39948.60051399478, 39985.0, 40128.79935600333, 5934.554908381802, 5945.970270148708, 5994.550408719363, 6043.939560604425, 6155.840917591323, 10819.350838949687, 10903.727406814893, 10915.072218861485, 10944.288621239593, 10959.780804383867, 5438.5102908844065, 5492.69790161537, 5528.75120619573, 5663.943360566424, 5665.943340566624, 3429.794212347267, 3486.651334866493, 3521.0845180252804, 3618.0593045808278, 3624.2389098289127, 2426.102342133422, 2439.499902519979, 2445.4864478459367, 2453.705555333371, 2459.8524088554746, 345.16470142255804, 345.9757816952789, 346.1968233697797, 347.27073146392877, 350.50753691064097, 501.97239151847, 518.1864472777703, 531.2827682628421, 558.9776408943596, 564.971751412436, 6524.934750652433, 7289.198188199294, 7630.427717921179, 7783.066032076187, 7891.644875980594, 385.4218671992012, 512.5489569179099, 544.9918251226235, 552.9612927095145, 554.8002719021149, 3341.665833416639, 3459.567554055743, 3589.515415418937, 3611.8013509257244, 3741.0, 53106.203406948924, 53377.46622533725, 53397.46602533925, 53426.198607020924, 53655.731721341144, 46362.5363746365, 47000.0, 47135.76432117886, 47173.76413117912, 47584.0, 41398.37902431466, 41856.16287674291, 41984.0, 42214.15571688549, 43003.13993720108, 7420.183779784327, 7431.516951398142, 7454.217307182667, 7683.193264707125, 7803.882941755992, 30338.0, 31344.0, 31414.214644633154, 31457.528137077505, 31471.37057258888, 39251.41122883216, 41147.0, 42130.0, 42707.786461067495, 42768.0, 6156.476699480415, 6333.493320534254, 6390.297067322498, 6580.638064906476, 6697.3637504437, 9445.433274003582, 9609.663661771805, 9731.610735570497, 9754.146712124673, 9947.751306217402, 8920.509371984603, 9043.819123617359, 9049.54752262371, 9055.320850936338, 9064.864027039468, 8739.956300218459, 8811.33914956368, 9015.729528114167, 9179.17387435134, 9186.173244408035, 9003.684871029482, 9051.366404351633, 9125.406848554823, 9285.210757085724, 9603.423794572349, 7829.0, 7950.960245198737, 8025.541255113099, 8183.590820459072, 8568.35737319691, 7670.058596969751, 8082.919170808216, 8110.797230069295, 8143.307818835466, 8250.298724608476]}, "summary": {"lowerIsBetter": false, "suite": 5875.658695712428, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5872.204609348254, "unit": "ms", "value": 5872.204609348254}, "dojo.html": {"lowerIsBetter": false, "filtered": 4785.1382228436505, "unit": "ms", "value": 4785.1382228436505}, "mootools.html": {"lowerIsBetter": false, "filtered": 3820.5748959509424, "unit": "ms", "value": 3820.5748959509424}, "ext.html": {"lowerIsBetter": false, "filtered": 16525.91456693549, "unit": "ms", "value": 16525.91456693549}, "prototype.html": {"lowerIsBetter": false, "filtered": 4467.001769114412, "unit": "ms", "value": 4467.001769114412}, "yui.html": {"lowerIsBetter": false, "filtered": 5191.481398964304, "unit": "ms", "value": 5191.481398964304}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0018"}, "testrun": {"date": 1447833979, "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": "20151117223936", "branch": "Fx-Team", "revision": "c699b2c839a9f8c2b964dd956de9084d3b93a13f"}}, {"talos_counters": {}, "results": {"audio-dft": [180.0, 179.0, 179.0, 183.0, 182.0, 178.0, 179.0, 180.0, 181.0, 180.0], "ai-astar": [111.0, 115.0, 114.0, 120.0, 122.0, 122.0, 121.0, 120.0, 113.0, 119.0], "imaging-gaussian-blur": [136.0, 135.0, 129.0, 135.0, 138.0, 135.0, 135.0, 129.0, 129.0, 135.0], "audio-beat-detection": [172.0, 145.0, 169.0, 189.0, 146.0, 168.0, 166.0, 140.0, 182.0, 143.0], "json-stringify-tinderbox": [73.0, 77.0, 77.0, 79.0, 80.0, 79.0, 81.0, 79.0, 79.0, 79.0], "stanford-crypto-pbkdf2": [176.0, 165.0, 176.0, 175.0, 176.0, 174.0, 174.0, 175.0, 174.0, 166.0], "json-parse-financial": [66.0, 67.0, 67.0, 68.0, 67.0, 67.0, 68.0, 77.0, 70.0, 70.0], "stanford-crypto-sha256-iterative": [76.0, 81.0, 80.0, 79.0, 80.0, 79.0, 80.0, 81.0, 87.0, 84.0], "audio-fft": [84.0, 85.0, 98.0, 99.0, 79.0, 78.0, 79.0, 89.0, 92.0, 75.0], "imaging-darkroom": [141.0, 141.0, 141.0, 141.0, 141.0, 150.0, 141.0, 142.0, 141.0, 141.0], "stanford-crypto-ccm": [143.0, 145.0, 148.0, 133.0, 142.0, 140.0, 141.0, 139.0, 145.0, 151.0], "audio-oscillator": [107.0, 111.0, 149.0, 99.0, 100.0, 100.0, 139.0, 98.0, 99.0, 142.0], "stanford-crypto-aes": [92.0, 96.0, 96.0, 100.0, 100.0, 97.0, 96.0, 98.0, 99.0, 101.0], "imaging-desaturate": [110.0, 105.0, 109.0, 117.0, 104.0, 113.0, 113.0, 119.0, 115.0, 105.0]}, "summary": {"lowerIsBetter": true, "suite": 1687.6, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 85.8, "unit": "ms", "value": 85.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 173.1, "unit": "ms", "value": 173.1}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 162.0, "unit": "ms", "value": 162.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 142.7, "unit": "ms", "value": 142.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 142.0, "unit": "ms", "value": 142.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 68.7, "unit": "ms", "value": 68.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 114.4, "unit": "ms", "value": 114.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 117.7, "unit": "ms", "value": 117.7}, "audio-dft": {"lowerIsBetter": true, "filtered": 180.1, "unit": "ms", "value": 180.1}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 80.7, "unit": "ms", "value": 80.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 78.3, "unit": "ms", "value": 78.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 133.6, "unit": "ms", "value": 133.6}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 97.5, "unit": "ms", "value": 97.5}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 111.0, "unit": "ms", "value": 111.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0018"}, "testrun": {"date": 1447833979, "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": "20151117223936", "branch": "Fx-Team", "revision": "c699b2c839a9f8c2b964dd956de9084d3b93a13f"}}, {"talos_counters": {}, "results": {"DeltaBlue": [213.85799828913602], "Encrypt": [358.03795202291445], "NavierStokes": [6477.419354838709], "Decrypt": [6211.180124223602], "Splay": [906.6183136899365], "Richards": [185.01387604070305], "RegExp": [32370.967741935485], "Earley": [996.01593625498], "Boyer": [14211.267605633802], "RayTrace": [2239.373601789709]}, "summary": {"lowerIsBetter": false, "suite": 16118.561792379254, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 309.1677679999999, "unit": "score", "value": 309.1677679999999}, "Encrypt": {"lowerIsBetter": false, "filtered": 743.4435329999997, "unit": "score", "value": 743.4435329999997}, "NavierStokes": {"lowerIsBetter": false, "filtered": 229.10358565737047, "unit": "score", "value": 229.10358565737047}, "Decrypt": {"lowerIsBetter": false, "filtered": 42.855141000000025, "unit": "score", "value": 42.855141000000025}, "Splay": {"lowerIsBetter": false, "filtered": 89.88457299999997, "unit": "score", "value": 89.88457299999997}, "RegExp": {"lowerIsBetter": false, "filtered": 28.142037867463863, "unit": "score", "value": 28.142037867463863}, "Richards": {"lowerIsBetter": false, "filtered": 190.80731000000003, "unit": "score", "value": 190.80731000000003}, "Earley": {"lowerIsBetter": false, "filtered": 669.1288519999998, "unit": "score", "value": 669.1288519999998}, "Boyer": {"lowerIsBetter": false, "filtered": 46.896801783944476, "unit": "score", "value": 46.896801783944476}, "RayTrace": {"lowerIsBetter": false, "filtered": 330.4446383616385, "unit": "score", "value": 330.4446383616385}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0018"}, "testrun": {"date": 1447833979, "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": "20151117223936", "branch": "Fx-Team", "revision": "c699b2c839a9f8c2b964dd956de9084d3b93a13f"}}] 00:26:35 INFO - RETURN: dromaeo_css: 5875.66 00:26:35 INFO - RETURN: kraken: 1687.60 00:26:35 INFO - RETURN: v8_7: 16118.56 00:26:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "16118.56"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1687.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "5875.66"}}} 00:26:35 INFO - Return code: 0 00:26:35 INFO - # TBPL SUCCESS # 00:26:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:26:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:26:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:26:35 INFO - 2015-11-18 00:26:35.722 screenresolution[1667:10645] starting screenresolution argv=screenresolution get 00:26:35 INFO - 2015-11-18 00:26:35.726 screenresolution[1667:10645] Display 0: 1600x1200x32@60 00:26:35 INFO - 2015-11-18 00:26:35.732 screenresolution[1668:10649] starting screenresolution argv=screenresolution list 00:26:35 INFO - Available Modes on Display 0 00:26:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:26:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:26:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:26:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:26:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:26:35 INFO - Intel HD Graphics 3000: 00:26:35 INFO - Chipset Model: Intel HD Graphics 3000 00:26:35 INFO - Type: GPU 00:26:35 INFO - Bus: Built-In 00:26:35 INFO - VRAM (Total): 512 MB 00:26:35 INFO - VRAM (Dynamic, Max): 10 00:26:35 INFO - Vendor: Intel (0x8086) 00:26:35 INFO - Device ID: 0x0116 00:26:35 INFO - Revision ID: 0x0009 00:26:35 INFO - Displays: 00:26:35 INFO - Display: 00:26:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:26:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:26:36 INFO - Display Serial Number: 1600x1200 60 00:26:36 INFO - Main Display: Yes 00:26:36 INFO - Mirror: Off 00:26:36 INFO - Online: Yes 00:26:36 INFO - Rotation: Supported 00:26:36 INFO - Return code: 0 00:26:36 INFO - Running post-action listener: _resource_record_post_action 00:26:36 INFO - Running post-run listener: _resource_record_post_run 00:26:37 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 40821760; Write bytes: 690593792; Read time: 5291; Write time: 59749 00:26:37 INFO - install - Wall time: 40s; CPU: 30.0%; Read bytes: 344062464; Write bytes: 348774400; Read time: 35425; Write time: 7883 00:26:37 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 38728704; Write bytes: 340611072; Read time: 4600; Write time: 51852 00:26:37 INFO - Running post-run listener: _upload_blobber_files 00:26:37 INFO - Blob upload gear active. 00:26:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 00:26:37 INFO - Copying logs to upload dir... 00:26:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1321.967600 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2015-11-18 00:26:37.160899) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 00:26:37.164829) ========= 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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010465 build_url: 'https://queue.taskcluster.net/v1/task/mND7yt19TQeJQ4ZSlYQDNA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-18 00:26:37.191012) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:26:37.191359) ========= 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.ZJgq0VvVTI/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.pDkqdjHCA2/Listeners TMPDIR=/var/folders/h_/qm_0_8l16mx72zdxd4g30gd800000w/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.005277 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-18 00:26:37.240727) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 00:26:37.241107) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-18 00:26:37.241643) ========= ========= Total master_lag: 0.53 =========