builder: fx-team_yosemite_test-dromaeojs slave: t-yosemite-r5-0029 starttime: 1447517914.63 results: success (0) buildid: 20151114072932 builduid: 8f33ad03917644c3827962b3b59fc00b revision: 3d8143254eac173858c97f6e0d3ae9a48be3dcbc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:34.625708) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:34.626144) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2015-11-14 08:18:34.626477) ========= 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.ISU0glyeF9/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.su9tswsi2h/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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.006152 basedir: '/builds/slave/test' ========= master_lag: 2.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2015-11-14 08:18:36.667938) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2015-11-14 08:18:36.668365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2015-11-14 08:18:37.703459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:37.703751) ========= 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.ISU0glyeF9/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.su9tswsi2h/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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.015103 ========= master_lag: 0.28 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:37.994660) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:37.994969) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:37.998494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:37.998858) ========= 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.ISU0glyeF9/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.su9tswsi2h/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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-14 08:18:38-- 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% 13.2M=0.001s 2015-11-14 08:18:38 (13.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.227637 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:38.269926) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:38.273334) ========= 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.ISU0glyeF9/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.su9tswsi2h/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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.053499 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:38.352410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:38.352759) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3d8143254eac173858c97f6e0d3ae9a48be3dcbc --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 3d8143254eac173858c97f6e0d3ae9a48be3dcbc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ISU0glyeF9/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.su9tswsi2h/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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-14 08:18:38,448 truncating revision to first 12 chars 2015-11-14 08:18:38,448 Setting DEBUG logging. 2015-11-14 08:18:38,448 attempt 1/10 2015-11-14 08:18:38,448 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3d8143254eac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-14 08:18:38,685 unpacking tar archive at: fx-team-3d8143254eac/testing/mozharness/ program finished with exit code 0 elapsedTime=0.494360 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:38.900698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:38.901056) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:38.924781) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:38.925273) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-14 08:18:38.925801) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 12 secs) (at 2015-11-14 08:18:38.926151) ========= /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.ISU0glyeF9/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.su9tswsi2h/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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 08:18:39 INFO - MultiFileLogger online at 20151114 08:18:39 in /builds/slave/test 08:18:39 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 08:18:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:39 INFO - {'append_to_log': False, 08:18:39 INFO - 'base_work_dir': '/builds/slave/test', 08:18:39 INFO - 'blob_upload_branch': 'Fx-Team', 08:18:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:39 INFO - 'branch': 'Fx-Team', 08:18:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:39 INFO - 'config_files': ('talos/mac_config.py',), 08:18:39 INFO - 'default_actions': ('clobber', 08:18:39 INFO - 'read-buildbot-config', 08:18:39 INFO - 'download-and-extract', 08:18:39 INFO - 'populate-webroot', 08:18:39 INFO - 'create-virtualenv', 08:18:39 INFO - 'install', 08:18:39 INFO - 'run-tests'), 08:18:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:39 INFO - 'download_minidump_stackwalk': True, 08:18:39 INFO - 'download_symbols': 'ondemand', 08:18:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:39 INFO - 'installer_path': 'installer.exe', 08:18:39 INFO - 'log_level': 'info', 08:18:39 INFO - 'log_name': 'talos', 08:18:39 INFO - 'log_to_console': True, 08:18:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:18:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:18:39 INFO - 'opt_config_files': (), 08:18:39 INFO - 'pip_index': False, 08:18:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:18:39 INFO - 'cmd': ('bash', 08:18:39 INFO - '-c', 08:18:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:18:39 INFO - 'enabled': True, 08:18:39 INFO - 'halt_on_failure': False, 08:18:39 INFO - 'name': 'check_screen_resolution'},), 08:18:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:18:39 INFO - 'cmd': ('bash', 08:18:39 INFO - '-c', 08:18:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:18:39 INFO - 'enabled': True, 08:18:39 INFO - 'halt_on_failure': False, 08:18:39 INFO - 'name': 'check_screen_resolution'},), 08:18:39 INFO - 'run_cmd_checks_enabled': True, 08:18:39 INFO - 'sps_profile': False, 08:18:39 INFO - 'sps_profile_interval': 0, 08:18:39 INFO - 'suite': 'dromaeojs', 08:18:39 INFO - 'system_bits': '64', 08:18:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:39 INFO - 'title': 't-yosemite-r5-0029', 08:18:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:39 INFO - 'use_talos_json': True, 08:18:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:39 INFO - 'work_dir': 'build'} 08:18:39 INFO - ##### 08:18:39 INFO - ##### Running clobber step. 08:18:39 INFO - ##### 08:18:39 INFO - Running pre-action listener: _resource_record_pre_action 08:18:39 INFO - Running main action method: clobber 08:18:39 INFO - rmtree: /builds/slave/test/build 08:18:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:43 INFO - Running post-action listener: _resource_record_post_action 08:18:43 INFO - ##### 08:18:43 INFO - ##### Running read-buildbot-config step. 08:18:43 INFO - ##### 08:18:43 INFO - Running pre-action listener: _resource_record_pre_action 08:18:43 INFO - Running main action method: read_buildbot_config 08:18:43 INFO - Using buildbot properties: 08:18:43 INFO - { 08:18:43 INFO - "properties": { 08:18:43 INFO - "buildnumber": 1343, 08:18:43 INFO - "product": "firefox", 08:18:43 INFO - "script_repo_revision": "production", 08:18:43 INFO - "builddir": "fx-team_yosemite_test-dromaeojs", 08:18:43 INFO - "repository": "", 08:18:43 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs", 08:18:43 INFO - "buildid": "20151114072932", 08:18:43 INFO - "slavename": "t-yosemite-r5-0029", 08:18:43 INFO - "pgo_build": "False", 08:18:43 INFO - "basedir": "/builds/slave/test", 08:18:43 INFO - "project": "", 08:18:43 INFO - "platform": "yosemite", 08:18:43 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:18:43 INFO - "slavebuilddir": "test", 08:18:43 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:18:43 INFO - "branch": "fx-team", 08:18:43 INFO - "repo_path": "integration/fx-team", 08:18:43 INFO - "stage_platform": "macosx64", 08:18:43 INFO - "builduid": "8f33ad03917644c3827962b3b59fc00b", 08:18:43 INFO - "revision": "3d8143254eac173858c97f6e0d3ae9a48be3dcbc" 08:18:43 INFO - }, 08:18:43 INFO - "sourcestamp": { 08:18:43 INFO - "repository": "", 08:18:43 INFO - "hasPatch": false, 08:18:43 INFO - "project": "", 08:18:43 INFO - "branch": "fx-team-macosx64-talos", 08:18:43 INFO - "changes": [ 08:18:43 INFO - { 08:18:43 INFO - "category": null, 08:18:43 INFO - "files": [ 08:18:43 INFO - { 08:18:43 INFO - "url": null, 08:18:43 INFO - "name": "https://queue.taskcluster.net/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 08:18:43 INFO - } 08:18:43 INFO - ], 08:18:43 INFO - "repository": "", 08:18:43 INFO - "rev": "3d8143254eac173858c97f6e0d3ae9a48be3dcbc", 08:18:43 INFO - "who": "jwein@mozilla.com", 08:18:43 INFO - "when": 1447517875, 08:18:43 INFO - "number": 6662280, 08:18:43 INFO - "comments": "Bug 1213421 - Follow-up, set the bodyText even when text is not being truncated. r=MattN", 08:18:43 INFO - "project": "", 08:18:43 INFO - "at": "Sat 14 Nov 2015 08:17:55", 08:18:43 INFO - "branch": "fx-team-macosx64-talos", 08:18:43 INFO - "revlink": "", 08:18:43 INFO - "properties": [ 08:18:43 INFO - [ 08:18:43 INFO - "buildid", 08:18:43 INFO - "20151114072932", 08:18:43 INFO - "Change" 08:18:43 INFO - ], 08:18:43 INFO - [ 08:18:43 INFO - "builduid", 08:18:43 INFO - "8f33ad03917644c3827962b3b59fc00b", 08:18:43 INFO - "Change" 08:18:43 INFO - ], 08:18:43 INFO - [ 08:18:43 INFO - "pgo_build", 08:18:43 INFO - "False", 08:18:43 INFO - "Change" 08:18:43 INFO - ] 08:18:43 INFO - ], 08:18:43 INFO - "revision": "3d8143254eac173858c97f6e0d3ae9a48be3dcbc" 08:18:43 INFO - } 08:18:43 INFO - ], 08:18:43 INFO - "revision": "3d8143254eac173858c97f6e0d3ae9a48be3dcbc" 08:18:43 INFO - } 08:18:43 INFO - } 08:18:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 08:18:43 INFO - Running post-action listener: _resource_record_post_action 08:18:43 INFO - ##### 08:18:43 INFO - ##### Running download-and-extract step. 08:18:43 INFO - ##### 08:18:43 INFO - Running pre-action listener: _resource_record_pre_action 08:18:43 INFO - Running main action method: download_and_extract 08:18:43 INFO - mkdir: /builds/slave/test/build/tests 08:18:43 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')]} 08:18:43 INFO - https://queue.taskcluster.net/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:18:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/test_packages.json 08:18:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/test_packages.json 08:18:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:18:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:18:57 INFO - Downloaded 1149 bytes. 08:18:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:18:57 INFO - Using the following test package requirements: 08:18:57 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:18:57 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:18:57 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 08:18:57 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:18:57 INFO - u'jsshell-mac.zip'], 08:18:57 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:18:57 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 08:18:57 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:18:57 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:18:57 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 08:18:57 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:18:57 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 08:18:57 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:18:57 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 08:18:57 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 08:18:57 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 08:18:57 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 08:18:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:18:57 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')]} 08:18:57 INFO - https://queue.taskcluster.net/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:18:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:18:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:18:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/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 08:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/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 08:19:09 INFO - Downloaded 17460986 bytes. 08:19:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 08:19:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:19:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:19:14 INFO - Return code: 0 08:19:14 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 08:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:14 INFO - https://queue.taskcluster.net/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:19:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:19:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:19:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/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 08:19:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/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 08:19:15 INFO - Downloaded 17460986 bytes. 08:19:15 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 08:19:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 08:19:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 08:19:22 INFO - Return code: 0 08:19:22 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')]} 08:19:22 INFO - https://queue.taskcluster.net/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:19:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:19:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:19:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/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 08:19:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/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 08:19:23 INFO - Downloaded 11131693 bytes. 08:19:23 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 08:19:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 08:19:23 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 08:19:23 INFO - Return code: 0 08:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:23 INFO - https://queue.taskcluster.net/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:19:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:19:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:19:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 08:19:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lU2yAzo6TMq2GkQu593RIQ/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 08:19:26 INFO - Downloaded 108701012 bytes. 08:19:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:19:26 INFO - mkdir: /builds/slave/test/properties 08:19:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:19:26 INFO - Writing to file /builds/slave/test/properties/build_url 08:19:26 INFO - Contents: 08:19:26 INFO - build_url:https://queue.taskcluster.net/v1/task/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 08:19:26 INFO - Running post-action listener: _resource_record_post_action 08:19:26 INFO - Running post-action listener: set_extra_try_arguments 08:19:26 INFO - ##### 08:19:26 INFO - ##### Running populate-webroot step. 08:19:26 INFO - ##### 08:19:26 INFO - Running pre-action listener: _resource_record_pre_action 08:19:26 INFO - Running main action method: populate_webroot 08:19:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:19:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:19:26 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:19:26 INFO - '../fennec_ids.txt'], 08:19:26 INFO - 'tests': ['tcheck2']}, 08:19:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:19:26 INFO - '--tppagecycles', 08:19:26 INFO - '7'], 08:19:26 INFO - 'tests': ['tsvgm']}}, 08:19:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:19:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:19:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:19:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:19:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:19:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'tests': ['damp', 'tps']}, 08:19:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['damp', 'tps']}, 08:19:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:19:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:19:26 INFO - 'other': {'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'other_l64': {'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'other_nol64': {'tests': ['a11yr', 08:19:26 INFO - 'ts_paint', 08:19:26 INFO - 'tpaint', 08:19:26 INFO - 'sessionrestore', 08:19:26 INFO - 'sessionrestore_no_auto_restore']}, 08:19:26 INFO - 'svgr': {'tests': ['tsvgx', 08:19:26 INFO - 'tsvgr_opacity', 08:19:26 INFO - 'tart', 08:19:26 INFO - 'tscrollx', 08:19:26 INFO - 'cart']}, 08:19:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['tsvgx', 08:19:26 INFO - 'tsvgr_opacity', 08:19:26 INFO - 'tart', 08:19:26 INFO - 'tscrollx', 08:19:26 INFO - 'cart']}, 08:19:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'tests': ['tp5o']}, 08:19:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'talos_options': ['--e10s'], 08:19:26 INFO - 'tests': ['tp5o']}, 08:19:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'talos_options': ['--xperf_path', 08:19:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:26 INFO - 'tests': ['tp5n']}, 08:19:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:19:26 INFO - 'talos_options': ['--e10s', 08:19:26 INFO - '--xperf_path', 08:19:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:19:26 INFO - 'tests': ['tp5n']}}, 08:19:26 INFO - 'talos.zip': {'path': '', 08:19:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:19:26 INFO - Running post-action listener: _resource_record_post_action 08:19:26 INFO - ##### 08:19:26 INFO - ##### Running create-virtualenv step. 08:19:26 INFO - ##### 08:19:26 INFO - Running pre-action listener: _resource_record_pre_action 08:19:26 INFO - Running main action method: create_virtualenv 08:19:26 INFO - Creating virtualenv /builds/slave/test/build/venv 08:19:26 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 08:19:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:19:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:19:26 INFO - Using real prefix '/tools/python27' 08:19:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:19:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:19:31 INFO - Installing pip.................done. 08:19:31 INFO - Return code: 0 08:19:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:31 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 0x10d21d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbae0c80080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1409f0>, '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 0x10cea0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1348c8>, '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.ISU0glyeF9/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.su9tswsi2h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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 08:19:31 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 08:19:31 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 08:19:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ISU0glyeF9/Render', 08:19:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:31 INFO - 'HOME': '/Users/cltbld', 08:19:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:31 INFO - 'LOGNAME': 'cltbld', 08:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:31 INFO - 'MOZ_NO_REMOTE': '1', 08:19:31 INFO - 'NO_EM_RESTART': '1', 08:19:31 INFO - 'PAGER': '/bin/cat', 08:19:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:31 INFO - 'PWD': '/builds/slave/test', 08:19:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:31 INFO - 'SHELL': '/bin/bash', 08:19:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.su9tswsi2h/Listeners', 08:19:31 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 08:19:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:31 INFO - 'USER': 'cltbld', 08:19:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:31 INFO - 'XPC_FLAGS': '0x0', 08:19:31 INFO - 'XPC_SERVICE_NAME': '0', 08:19:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:31 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 08:19:31 INFO - Cleaning up... 08:19:32 INFO - Return code: 0 08:19:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:19: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')]} 08:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19: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')]} 08:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d21d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbae0c80080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1409f0>, '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 0x10cea0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1348c8>, '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.ISU0glyeF9/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.su9tswsi2h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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 08:19:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:19:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ISU0glyeF9/Render', 08:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:32 INFO - 'HOME': '/Users/cltbld', 08:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:32 INFO - 'LOGNAME': 'cltbld', 08:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:32 INFO - 'MOZ_NO_REMOTE': '1', 08:19:32 INFO - 'NO_EM_RESTART': '1', 08:19:32 INFO - 'PAGER': '/bin/cat', 08:19:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:32 INFO - 'PWD': '/builds/slave/test', 08:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:32 INFO - 'SHELL': '/bin/bash', 08:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.su9tswsi2h/Listeners', 08:19:32 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 08:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:32 INFO - 'USER': 'cltbld', 08:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:32 INFO - 'XPC_FLAGS': '0x0', 08:19:32 INFO - 'XPC_SERVICE_NAME': '0', 08:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:32 INFO - Downloading/unpacking psutil>=0.7.1 08:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:34 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:19:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:19:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:34 INFO - Installing collected packages: psutil 08:19:34 INFO - Running setup.py install for psutil 08:19:34 INFO - building 'psutil._psutil_osx' extension 08:19:34 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 08:19:36 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 08:19:36 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 08:19:36 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 08:19:37 INFO - building 'psutil._psutil_posix' extension 08:19:37 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 08:19:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:19:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:19:37 INFO - ^ 08:19:37 INFO - 1 warning generated. 08:19:37 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 08:19:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:19:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:19:37 INFO - Successfully installed psutil 08:19:37 INFO - Cleaning up... 08:19:37 INFO - Return code: 0 08:19:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:37 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 0x10d21d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbae0c80080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1409f0>, '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 0x10cea0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1348c8>, '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.ISU0glyeF9/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.su9tswsi2h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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 08:19:37 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 08:19:37 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 08:19:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ISU0glyeF9/Render', 08:19:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:37 INFO - 'HOME': '/Users/cltbld', 08:19:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:37 INFO - 'LOGNAME': 'cltbld', 08:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:37 INFO - 'MOZ_NO_REMOTE': '1', 08:19:37 INFO - 'NO_EM_RESTART': '1', 08:19:37 INFO - 'PAGER': '/bin/cat', 08:19:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:37 INFO - 'PWD': '/builds/slave/test', 08:19:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:37 INFO - 'SHELL': '/bin/bash', 08:19:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.su9tswsi2h/Listeners', 08:19:37 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 08:19:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:37 INFO - 'USER': 'cltbld', 08:19:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:37 INFO - 'XPC_FLAGS': '0x0', 08:19:37 INFO - 'XPC_SERVICE_NAME': '0', 08:19:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:19:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:19:37 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 08:19:37 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 08:19:37 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 08:19:37 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 08:19:37 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 08:19:37 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 08:19:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:19:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:19:40 INFO - Installing collected packages: mozsystemmonitor 08:19:40 INFO - Running setup.py install for mozsystemmonitor 08:19:40 INFO - Successfully installed mozsystemmonitor 08:19:40 INFO - Cleaning up... 08:19:40 INFO - Return code: 0 08:19:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:40 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 0x10d21d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbae0c80080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1409f0>, '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 0x10cea0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1348c8>, '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.ISU0glyeF9/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.su9tswsi2h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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 08:19:40 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 08:19:40 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 08:19:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ISU0glyeF9/Render', 08:19:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:40 INFO - 'HOME': '/Users/cltbld', 08:19:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:40 INFO - 'LOGNAME': 'cltbld', 08:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:40 INFO - 'MOZ_NO_REMOTE': '1', 08:19:40 INFO - 'NO_EM_RESTART': '1', 08:19:40 INFO - 'PAGER': '/bin/cat', 08:19:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:40 INFO - 'PWD': '/builds/slave/test', 08:19:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:40 INFO - 'SHELL': '/bin/bash', 08:19:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.su9tswsi2h/Listeners', 08:19:40 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 08:19:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:40 INFO - 'USER': 'cltbld', 08:19:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:40 INFO - 'XPC_FLAGS': '0x0', 08:19:40 INFO - 'XPC_SERVICE_NAME': '0', 08:19:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:19:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:40 INFO - Downloading/unpacking blobuploader==1.2.4 08:19:40 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 08:19:40 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 08:19:40 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 08:19:40 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 08:19:40 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 08:19:40 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 08:19:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:19:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:19:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:19:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:19:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:19:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:19:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:19:44 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 08:19:44 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 08:19:44 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 08:19:44 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 08:19:44 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 08:19:44 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 08:19:44 INFO - Downloading docopt-0.6.1.tar.gz 08:19:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:19:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:19:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:19:44 INFO - Running setup.py install for blobuploader 08:19:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:19:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:19:44 INFO - Running setup.py install for requests 08:19:45 INFO - Running setup.py install for docopt 08:19:45 INFO - Successfully installed blobuploader requests docopt 08:19:45 INFO - Cleaning up... 08:19:45 INFO - Return code: 0 08:19:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:45 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')]} 08:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:45 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')]} 08:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:45 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 0x10d21d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbae0c80080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1409f0>, '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 0x10cea0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1348c8>, '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.ISU0glyeF9/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.su9tswsi2h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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 08:19:45 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 08:19:45 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 08:19:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ISU0glyeF9/Render', 08:19:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:45 INFO - 'HOME': '/Users/cltbld', 08:19:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:45 INFO - 'LOGNAME': 'cltbld', 08:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:45 INFO - 'MOZ_NO_REMOTE': '1', 08:19:45 INFO - 'NO_EM_RESTART': '1', 08:19:45 INFO - 'PAGER': '/bin/cat', 08:19:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:45 INFO - 'PWD': '/builds/slave/test', 08:19:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:45 INFO - 'SHELL': '/bin/bash', 08:19:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.su9tswsi2h/Listeners', 08:19:45 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 08:19:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:45 INFO - 'USER': 'cltbld', 08:19:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:45 INFO - 'XPC_FLAGS': '0x0', 08:19:45 INFO - 'XPC_SERVICE_NAME': '0', 08:19:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:45 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-IS8LnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:45 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-CnRvdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:46 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-Re5rxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:46 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-5rfPS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:46 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-AV_KNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:46 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-Xvijcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:46 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-EgR5kH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:46 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-DerDjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:46 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-Irl5G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:46 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-O0MdDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:47 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-SRmZou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:47 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-J8bJi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:47 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-d7jO1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:47 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-phvdh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:47 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-9BuHLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:47 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-lMevd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:47 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-8Ngjld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:19:47 INFO - Running setup.py install for manifestparser 08:19:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:19:48 INFO - Running setup.py install for mozcrash 08:19:48 INFO - Running setup.py install for mozdebug 08:19:48 INFO - Running setup.py install for mozdevice 08:19:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:19:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:19:48 INFO - Running setup.py install for mozfile 08:19:48 INFO - Running setup.py install for mozhttpd 08:19:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:19:48 INFO - Running setup.py install for mozinfo 08:19:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:19:49 INFO - Running setup.py install for mozInstall 08:19:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:19:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:19:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:19:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:19:49 INFO - Running setup.py install for mozleak 08:19:49 INFO - Running setup.py install for mozlog 08:19:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:19:49 INFO - Running setup.py install for moznetwork 08:19:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:19:49 INFO - Running setup.py install for mozprocess 08:19:50 INFO - Running setup.py install for mozprofile 08:19:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:19:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:19:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:19:50 INFO - Running setup.py install for mozrunner 08:19:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:19:50 INFO - Running setup.py install for mozscreenshot 08:19:50 INFO - Running setup.py install for moztest 08:19:50 INFO - Running setup.py install for mozversion 08:19:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:19:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:19:51 INFO - Cleaning up... 08:19:51 INFO - Return code: 0 08:19:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:51 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')]} 08:19:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:51 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')]} 08:19:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:51 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 0x10d21d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbae0c80080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1409f0>, '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 0x10cea0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1348c8>, '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.ISU0glyeF9/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.su9tswsi2h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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 08:19:51 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 08:19:51 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 08:19:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ISU0glyeF9/Render', 08:19:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:51 INFO - 'HOME': '/Users/cltbld', 08:19:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:51 INFO - 'LOGNAME': 'cltbld', 08:19:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:51 INFO - 'MOZ_NO_REMOTE': '1', 08:19:51 INFO - 'NO_EM_RESTART': '1', 08:19:51 INFO - 'PAGER': '/bin/cat', 08:19:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:51 INFO - 'PWD': '/builds/slave/test', 08:19:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:51 INFO - 'SHELL': '/bin/bash', 08:19:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.su9tswsi2h/Listeners', 08:19:51 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 08:19:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:51 INFO - 'USER': 'cltbld', 08:19:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:51 INFO - 'XPC_FLAGS': '0x0', 08:19:51 INFO - 'XPC_SERVICE_NAME': '0', 08:19:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:19:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:19:51 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-JbNi86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:19:51 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)) 08:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:19:51 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-oi2LOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:19:51 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)) 08:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:19:51 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-OZOwXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:19:51 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)) 08:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:19:51 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-LRuaUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:19:51 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)) 08:19:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:19:51 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-C2x8m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:19:52 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)) 08:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:19:52 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-_1FFii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:19:52 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)) 08:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:19:52 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-6HKvgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:19:52 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)) 08:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:19:52 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-lY2BlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:19:52 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)) 08:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:19:52 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-1Qbc3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:19:52 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)) 08:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:19:52 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-gKWc1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:19:52 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)) 08:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:19:52 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-szOMpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:19:52 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)) 08:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:19:52 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-7trCgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:19:52 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)) 08:19:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:19:52 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-rPBlCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:19:53 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)) 08:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:19:53 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-ikEQpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:19:53 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)) 08:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:53 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-9wTqMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:19:53 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)) 08:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:19:53 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-zrIsuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:19:53 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)) 08:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:19:53 INFO - Running setup.py (path:/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/pip-H6H5vA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:19:53 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)) 08:19:53 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)) 08:19:53 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)) 08:19:53 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)) 08:19:53 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)) 08:19:53 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)) 08:19:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:19:53 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 08:19:53 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 08:19:53 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 08:19:53 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 08:19:53 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 08:19:53 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 08:19:55 INFO - Downloading blessings-1.5.1.tar.gz 08:19:55 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 08:19:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:19:56 INFO - Installing collected packages: blessings 08:19:56 INFO - Running setup.py install for blessings 08:19:56 INFO - Successfully installed blessings 08:19:56 INFO - Cleaning up... 08:19:56 INFO - Return code: 0 08:19:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:19:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:56 INFO - Reading from file tmpfile_stdout 08:19:56 INFO - Current package versions: 08:19:56 INFO - blessings == 1.5.1 08:19:56 INFO - blobuploader == 1.2.4 08:19:56 INFO - docopt == 0.6.1 08:19:56 INFO - manifestparser == 1.1 08:19:56 INFO - mozInstall == 1.12 08:19:56 INFO - mozcrash == 0.16 08:19:56 INFO - mozdebug == 0.1 08:19:56 INFO - mozdevice == 0.47 08:19:56 INFO - mozfile == 1.2 08:19:56 INFO - mozhttpd == 0.7 08:19:56 INFO - mozinfo == 0.9 08:19:56 INFO - mozleak == 0.1 08:19:56 INFO - mozlog == 3.0 08:19:56 INFO - moznetwork == 0.27 08:19:56 INFO - mozprocess == 0.22 08:19:56 INFO - mozprofile == 0.27 08:19:56 INFO - mozrunner == 6.11 08:19:56 INFO - mozscreenshot == 0.1 08:19:56 INFO - mozsystemmonitor == 0.0 08:19:56 INFO - moztest == 0.7 08:19:56 INFO - mozversion == 1.4 08:19:56 INFO - psutil == 3.1.1 08:19:56 INFO - requests == 1.2.3 08:19:56 INFO - wsgiref == 0.1.2 08:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:19:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x10d21d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1fa228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbae0c80080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1409f0>, '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 0x10cea0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1348c8>, '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.ISU0glyeF9/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.su9tswsi2h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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 08:19:56 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 08:19:56 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 08:19:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ISU0glyeF9/Render', 08:19:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:19:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:19:56 INFO - 'HOME': '/Users/cltbld', 08:19:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:19:56 INFO - 'LOGNAME': 'cltbld', 08:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:56 INFO - 'MOZ_NO_REMOTE': '1', 08:19:56 INFO - 'NO_EM_RESTART': '1', 08:19:56 INFO - 'PAGER': '/bin/cat', 08:19:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:56 INFO - 'PWD': '/builds/slave/test', 08:19:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:19:56 INFO - 'SHELL': '/bin/bash', 08:19:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.su9tswsi2h/Listeners', 08:19:56 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 08:19:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:19:56 INFO - 'USER': 'cltbld', 08:19:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:19:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:56 INFO - 'XPC_FLAGS': '0x0', 08:19:56 INFO - 'XPC_SERVICE_NAME': '0', 08:19:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:19:57 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)) 08:19:57 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)) 08:19:57 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)) 08:19:57 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)) 08:19:57 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)) 08:19:57 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)) 08:19:57 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)) 08:19:57 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)) 08:19:57 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)) 08:19:57 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)) 08:19:57 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)) 08:19:57 INFO - Cleaning up... 08:19:57 INFO - Return code: 0 08:19:57 INFO - Running post-action listener: _resource_record_post_action 08:19:57 INFO - Running post-action listener: _start_resource_monitoring 08:19:57 INFO - Starting resource monitoring. 08:19:57 INFO - ##### 08:19:57 INFO - ##### Running install step. 08:19:57 INFO - ##### 08:19:57 INFO - Running pre-action listener: _resource_record_pre_action 08:19:57 INFO - Running main action method: install 08:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:19:57 INFO - Reading from file tmpfile_stdout 08:19:57 INFO - Detecting whether we're running mozinstall >=1.0... 08:19:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:19:57 INFO - Reading from file tmpfile_stdout 08:19:57 INFO - Output received: 08:19:57 INFO - Usage: mozinstall [options] installer 08:19:57 INFO - Options: 08:19:57 INFO - -h, --help show this help message and exit 08:19:57 INFO - -d DEST, --destination=DEST 08:19:57 INFO - Directory to install application into. [default: 08:19:57 INFO - "/builds/slave/test"] 08:19:57 INFO - --app=APP Application being installed. [default: firefox] 08:19:57 INFO - mkdir: /builds/slave/test/build/application 08:19:57 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'] 08:19:57 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 08:20:35 INFO - Reading from file tmpfile_stdout 08:20:35 INFO - Output received: 08:20:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:20:35 INFO - Running post-action listener: _resource_record_post_action 08:20:35 INFO - ##### 08:20:35 INFO - ##### Running run-tests step. 08:20:35 INFO - ##### 08:20:35 INFO - Running pre-action listener: _resource_record_pre_action 08:20:35 INFO - Running main action method: run_tests 08:20:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:20:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:20:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:20:35 INFO - 2015-11-14 08:20:35.812 screenresolution[1625:7808] starting screenresolution argv=screenresolution get 08:20:35 INFO - 2015-11-14 08:20:35.815 screenresolution[1625:7808] Display 0: 1600x1200x32@60 08:20:35 INFO - 2015-11-14 08:20:35.822 screenresolution[1626:7810] starting screenresolution argv=screenresolution list 08:20:35 INFO - Available Modes on Display 0 08:20:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:20:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:20:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:20:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:20:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:20:36 INFO - Intel HD Graphics 3000: 08:20:36 INFO - Chipset Model: Intel HD Graphics 3000 08:20:36 INFO - Type: GPU 08:20:36 INFO - Bus: Built-In 08:20:36 INFO - VRAM (Total): 512 MB 08:20:36 INFO - VRAM (Dynamic, Max): 10 08:20:36 INFO - Vendor: Intel (0x8086) 08:20:36 INFO - Device ID: 0x0116 08:20:36 INFO - Revision ID: 0x0009 08:20:36 INFO - Displays: 08:20:36 INFO - Display: 08:20:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:20:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:20:36 INFO - Display Serial Number: 1600x1200 60 08:20:36 INFO - Main Display: Yes 08:20:36 INFO - Mirror: Off 08:20:36 INFO - Online: Yes 08:20:36 INFO - Rotation: Supported 08:20:36 INFO - Return code: 0 08:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:20:36 INFO - Python 2.7.3 08:20:36 INFO - Return code: 0 08:20:36 INFO - grabbing minidump binary from tooltool 08:20:36 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')]} 08:20:36 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 0x10d1409f0>, '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 0x10cea0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d1348c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:20:36 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 08:20:36 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 08:20:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:20:36 INFO - Return code: 0 08:20:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:20:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:20:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:20:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:20:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:20:36 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/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0029', '--webServer', 'localhost'] in /builds/slave/test/build 08:20:36 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/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0029 --webServer localhost 08:20:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ISU0glyeF9/Render', 08:20:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:20:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:20:36 INFO - 'HOME': '/Users/cltbld', 08:20:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:20:36 INFO - 'LOGNAME': 'cltbld', 08:20:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:20:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:36 INFO - 'MOZ_NO_REMOTE': '1', 08:20:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:20:36 INFO - 'NO_EM_RESTART': '1', 08:20:36 INFO - 'PAGER': '/bin/cat', 08:20:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:36 INFO - 'PWD': '/builds/slave/test', 08:20:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:20:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:20:36 INFO - 'SHELL': '/bin/bash', 08:20:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.su9tswsi2h/Listeners', 08:20:36 INFO - 'TMPDIR': '/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/', 08:20:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:20:36 INFO - 'USER': 'cltbld', 08:20:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:20:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:36 INFO - 'XPC_FLAGS': '0x0', 08:20:36 INFO - 'XPC_SERVICE_NAME': '0', 08:20:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 08:20:36 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/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0029', '--webServer', 'localhost'] with output_timeout 3600 08:20:36 INFO - mozversion INFO | application_buildid: 20151114072932 08:20:36 INFO - mozversion INFO | application_changeset: 3d8143254eac173858c97f6e0d3ae9a48be3dcbc 08:20:36 INFO - mozversion INFO | application_display_name: Nightly 08:20:36 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:20:36 INFO - mozversion INFO | application_name: Firefox 08:20:36 INFO - mozversion INFO | application_remotingname: firefox 08:20:36 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:20:36 INFO - mozversion INFO | application_vendor: Mozilla 08:20:36 INFO - mozversion INFO | application_version: 45.0a1 08:20:36 INFO - mozversion INFO | platform_buildid: 20151114072932 08:20:36 INFO - mozversion INFO | platform_changeset: 3d8143254eac173858c97f6e0d3ae9a48be3dcbc 08:20:36 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:20:36 INFO - mozversion INFO | platform_version: 45.0a1 08:20:36 INFO - 2015-11-14 08:20:36,554 DEBUG : using testdate: 1447518036 08:20:36 INFO - 2015-11-14 08:20:36,554 DEBUG : actual date: 1447518036 08:20:36 INFO - 2015-11-14 08:20:36,640 INFO : starting webserver on 'localhost:49263' 08:20:36 INFO - 2015-11-14 08:20:36,642 INFO : Starting test suite t-yosemite-r5-0029 08:20:36 INFO - 2015-11-14 08:20:36,642 INFO : Starting test dromaeo_css 08:20:36 INFO - 2015-11-14 08:20:36,642 DEBUG : operating with platform_type : mac_ 08:20:36 INFO - 2015-11-14 08:20:36,643 INFO : Initialising browser for dromaeo_css test... 08:20:36 INFO - 2015-11-14 08:20:36,668 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmpzjZOlh/profile http://localhost:49263/getInfo.html 08:20:40 INFO - 2015-11-14 08:20:40,138 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:20:40 INFO - 2015-11-14 08:20:40,139 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:20:40 INFO - 2015-11-14 08:20:40,139 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:20:40 INFO - 2015-11-14 08:20:40,139 DEBUG : BROWSER_OUTPUT: __metrics 08:20:40 INFO - 2015-11-14 08:20:40,159 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:20:40 INFO - 2015-11-14 08:20:40,905 INFO : Browser initialized. 08:20:40 INFO - 2015-11-14 08:20:40,905 INFO : Running cycle 1/1 for dromaeo_css test... 08:20:40 INFO - 2015-11-14 08:20:40,906 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmpzjZOlh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:20:52 INFO - 2015-11-14 08:20:52,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 229384192 08:20:52 INFO - 2015-11-14 08:20:52,887 DEBUG : BROWSER_OUTPUT: 08:21:43 INFO - 2015-11-14 08:21:43,916 DEBUG : BROWSER_OUTPUT: 1447518103914 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] 08:23:54 INFO - 2015-11-14 08:23:54,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49263/tests/dromaeo/cssquery-ext.html) 08:23:56 INFO - 2015-11-14 08:23:56,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 344739840 08:23:56 INFO - 2015-11-14 08:23:56,125 DEBUG : BROWSER_OUTPUT: 08:26:58 INFO - 2015-11-14 08:26:58,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-ext.html (next: http://localhost:49263/tests/dromaeo/cssquery-jquery.html) 08:26:59 INFO - 2015-11-14 08:26:59,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 352522240 08:26:59 INFO - 2015-11-14 08:26:59,558 DEBUG : BROWSER_OUTPUT: 08:30:01 INFO - 2015-11-14 08:30:01,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49263/tests/dromaeo/cssquery-mootools.html) 08:30:02 INFO - 2015-11-14 08:30:02,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 326754304 08:30:02 INFO - 2015-11-14 08:30:02,436 DEBUG : BROWSER_OUTPUT: 08:33:04 INFO - 2015-11-14 08:33:04,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49263/tests/dromaeo/cssquery-prototype.html) 08:33:05 INFO - 2015-11-14 08:33:05,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 319655936 08:33:05 INFO - 2015-11-14 08:33:05,069 DEBUG : BROWSER_OUTPUT: 08:36:08 INFO - 2015-11-14 08:36:08,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49263/tests/dromaeo/cssquery-yui.html) 08:36:08 INFO - 2015-11-14 08:36:08,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 321171456 08:36:08 INFO - 2015-11-14 08:36:08,834 DEBUG : BROWSER_OUTPUT: 08:39:11 INFO - 2015-11-14 08:39:11,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/dromaeo/cssquery-yui.html (next: http://localhost:49263/tests/dromaeo/cssquery-dojo.html) 08:39:11 INFO - 2015-11-14 08:39:11,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 372445184 08:39:11 INFO - 2015-11-14 08:39:11,970 DEBUG : BROWSER_OUTPUT: 08:39:11 INFO - 2015-11-14 08:39:11,970 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:39:11 INFO - 2015-11-14 08:39:11,970 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:39:11 INFO - 2015-11-14 08:39:11,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:39:11 INFO - 2015-11-14 08:39:11,971 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:39:11 INFO - 2015-11-14 08:39:11,972 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2944.6908074652147;2980.5976193213924;3058.8929387471444;3091.412631599996;3153.0068028571;4771.785269662865;4776.71339719617;4934.8766280843;4958.826441074563;5028;4896.314515967767;4901.754912254391;4904.239842824368;4913.508649135094;5066.873328166797;4538.455385353762;4581.816727330903;4602.930956035662;4633.698809577367;4651;4596.149712303235;4598.080383923212;4660.1844677181525;4663.090697314025;4669.042846216517;4395.758233297167;4440.622547083502;4510.526394728539;4528.660350473728;4547.113312903985;4561.156186105581;4573.382593349888;4590.678652494326;4598.4711758147905;4612.192866248393;4518.887027824298;4537.274036154233;4538.8865278367975;4570.223062079454;4572.382728331666;4696.436427628672;4808.182608956486;4811.182099043171;4847.927281090787;4888.046830867982;5218.947810521884;5220.686758794446;5221.373435187802;5221.425643179247;5236.188390799394;5290.259363689087;5318.707471089088;5329.360476742816;5385.976664433784;5409.459054094559;4659.697119687209;4742.928856067162;4754;4780.426348838162;4950.702957822542;5357.383900851374;5413.431589683105;5419.078756611386;5443.591730620219;5454.209139674805;5163.225516172604;5166.870828229325;5168.250603662448;5176.404713457925;5177.741112944338;4981.800727970841;5115.411727651293;5132.948670513247;5200.479952004845;5314.229436731653;5136.101182293159;5137.614678899097;5140.768665409991;5155.226715992631;5239.423663397023;5169.017886601534;5169.095408303532;5188.273641690166;5224.346956630421;5286.20706893969;3913.62820532049;3976.4234186042863;4020.8994775130273;4032.4556184915245;4037.37420699792;3677.3196958562216;3706.703463722896;3718.2377612589353;3719.4420836874683;3731.3470142724914;4964.726940018261;4967.677100988496;4973.303737476756;4986.252062190628;4990.8253211137435;5075.593952483792;5238.292830467914;5294.602904782157;5298.549623282064;5319.707416092075;4952.380952380952;4986.8753281168265;4994.950050499521;5015.398152221684;5067.569256613229;4674.555917187861;4690.390249267573;4706.1528924793865;4769.165396055676;4773.856784296477;5269.288646032813;5318.946810531846;5319.521243088141;5361.490658387447;5481.945180548223;5334.493223143795;5359.705216213146;5367.114426119647;5456;5472.261244731911;5462.9180562292395;5528.06022976103;5533.806316778893;5547.223388725501;5572.192032155396;4948.05986862495;5093.108705976513;5100.515451032146;5177.068127737043;5261.421243663118;5155.742212889266;5183.98912212115;5195.246689229964;5218.608604354613;5302.151655735064;5053.595712343077;5081.263216833612;5082.618803589819;5083.822066227664;5119.334486516878;4892.315075889307;5017.397912250553;5080.669756465818;5104.9489505104475;5112;4957.355543779286;5093.490650935025;5098.79604815818;5099.184130539096;5121.923171152361;5174.948250517597;5175.585953123817;5192.749070234029;5229.529342359206;5289.894202116013;4828.565429111397;4979.576735977483;4984.700917944935;5041.546260836542;5134.948650513447 08:39:11 INFO - 2015-11-14 08:39:11,973 DEBUG : BROWSER_OUTPUT: |1;ext.html;509.317514530529;512.2751306900735;523.871651445396;531.0123170902123;543.5895898596564;28353.716462835364;29625;36801.079973000655;37201.62798372016;38199.80900095503;40291.39562906551;40452.39321410181;40886.38670419939;40888.79555602218;40937.385939210864;7629.8474030519355;8591.012033616136;8746.300295976307;8746.737597872043;8785.033646298902;7411.48119631626;9835.508224588777;10214.13179879711;10237.334573252714;10278.177745780356;10129.3922364658;10292.536835842406;10331.63839265626;10338.948305258464;10359.79280414395;7796.415268854858;8014.599270036475;10268.127209187229;10291.742706432324;10354.741131471697;9903.158231550255;10154.08613224806;10154.187664986783;10165.237607179492;10183.28716989811;36762.63237367619;37435.625643743486;37785;37914.8104259477;37928.43107353392;2573.266619013591;2686.637303963979;2869.2826793301674;2907.0261462410117;3151.3854798314337;25939.48121037569;26046.479070418674;26245.73754262452;26616.73383266162;26737.465250694877;2241.2267767620147;2248.9437764055865;2262.7850354216325;2282.189822612965;2353.8113252807393;247098;250206;252756;253212;254714;53524.99999999922;54581.1812822808;58114;58544;58621.70689146612;60980.69509652512;61059.38940610626;61430.38569614247;61859;61862.69068654628;13552.864471355357;13675.179489230679;13681.742512485329;13821.447142114404;13849.515266965607;9978.351407158656;10114.393136411838;10137.239707022003;10269.383836969657;10275.229357798195;18769;18886.3389781357;19123.330683426015;19137.712934305997;19215.51961200981;7369.520981136209;7630.8092297693;7678.308952194329;7735.994320738268;7737.1102323233545;854.7777577829809;910.2444970674325;992.5831150916632;1000.0449570660147;1048.3185929146116;26505.867470662524;26717.198484045508;26753.464930701666;26893.731062689123;26983.730162698514;960.1742501448888;966.1160038564634;1009.2178561614808;1055.8416237564272;1059.0045357364054;12833.165844220095;12876.549320773727;13113.606591802261;13125.474981000652;13172.736545269041;221165;225900;225957;226260;227320;51084.48915510797;51649;51853.48146518562;51952.22071668928;52045;1268.1123213750411;1270.4410059573943;1280.705437749323;1284.8137020132215;1288.935553222335;24970;25509.3622659435;25657.230283091536;25794.355141120872;25810;40165.39751903782;40247.79876100601;40331.395029075175;40378;40465.59534404736;265739;269127;269586;270229;270390;25662.743372566034;25769.226923192335;25944.846741394555;26064.609030864172;28813.423731525672;30580.847095765268;32881;33493.83253083719;35309.29381412306;39977.40033899552;31938.520922185722;32322;33198;33301.50047749334;33524.329513410084;32512.51231231581;32559;33030.834845825615;33078.669213307556;33175.83412082924;28799.424011519233;29315.12054638364;29375;34137.146571334924;34699.82650086733;25701.485970280115;26712.599311009963;28337.43325133527;29110.854445727637;29682.406351873273;20924.47688807792;21274.255401060887;21455.570888581828;22037.889810550845;22268.220612278492 08:39:11 INFO - 2015-11-14 08:39:11,977 DEBUG : BROWSER_OUTPUT: |2;jquery.html;306.7591940326844;307.8953155926984;310.7420840702219;312.05914168781123;312.6576398843267;13958.651033724162;14305.141691498491;14470.059446136007;15972.2013899305;16559;14313.928430357833;16266.593335166597;16347.26437310321;16877.07176105317;16996.4051258206;4211.284081706102;4893.951060489385;4989.575886049672;5053.823116190934;5106.770195341219;3620.3302389057976;3695.2794205130012;3745.644163804448;4941.135301322254;4988.2766998785155;5306;5328.307320048408;5364.409914909357;5449.209864569635;5466.753996070166;5321.627486075957;5325.627206095575;5417.26866872971;5527.695976721278;5554.805581804638;4646.814127434898;4651.186042442559;4653.48761652461;4704.905901881977;4722.716637001791;19368;19493.220271189137;19755.111020004133;19955.401337959884;20007.1997120115;1886.352704317688;1890.914908829106;1905.9809401905943;2105.1684584589157;2186.7157269554855;12021.639350819489;12373.566925157576;12386.5664701735;12564.748705025848;12895.935520322339;1504.2178067404998;1541.7764424158547;1545.7526795712745;1563.2340153324903;1579.5656194546477;45925;48107.27839082381;48385.51614483845;48754.51245487571;50068.74965625185;5838.38696936824;5923.911141332884;5975.043992961192;6003.189569408074;6035.39646035393;6847.1783385994;6889.069975553236;6905.447564194852;6944.895826562605;7012.5792452453015;4579.267317229227;4596.908061838744;4611.538846115429;4654;4712.5994290485005;4655.627549796008;4672.159011377917;4698.600618947359;4782.497837727058;4794.7362895040405;2685.368938299498;2691.4078902641386;2693.192042387276;2704.8647567621933;2709.593560965871;870.6517393042707;923.1045885491063;931.5435436636135;997.9501024948869;1002.2282842211602;389.795357437342;421.1030505024279;421.80386120454136;437.35053445633207;437.964962802975;10424.895751042544;10768.676939691823;10775.83836242457;10813.67558973232;10875.129989600813;417.353102690828;429.8925268682829;434.4070343980444;437.10611798871383;439.34318194299726;5755.050416681201;5834.708264586839;5891.027980383275;5907.734151963172;5980.700964951735;429490;469116;480488;485892;489116;61305.693471533246;61961.38038619556;61995;62544.37455625476;64113;451.4988362917159;466.05158502448035;466.8856130248111;470.1067970855402;471.7004702014246;9743.853842192231;9795.559199836167;9921.851172232567;9976.50117494137;10017.298789084694;29849.70150298556;29854.850725747103;30090;30247.395052098396;30882.0735377939;43858.56141438672;44964.55035449735;45434.54565454303;45873.311900320856;48493.51506485031;12871.613851584467;13267.137636053625;13682.931585342409;13747.381367838272;13852.861471385157;16873.07198104116;16937.06846123426;17161;17204.31182752676;17251.65496690034;7647.617619119133;7778.727744528915;7903.209679032281;8463.322934165375;8585.570721464026;8415.8737618937;8492.575371231538;8579.65681372738;8623.611937462703;8899.688510902088;7621.12357078943;7885.763427097197;8016.278534931884;8769.38614296993;8909.420887642282;13171.538996135472;13198.14212076212;13556.051076424556;13580.524681636096;13677.931610341884;13813.171209727449;13849.723005540034;13868;13976.650583735487;13989.720205596035 08:39:11 INFO - 2015-11-14 08:39:11,977 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1436.942522299108;1618.3122173076442;1680.8487236148744;1697.6604679064183;1708.333749837563;6402.263739669934;6665.966670166648;7026.367626913577;7288.416926645868;7310.926890731104;7134.322239387263;7231.819204519877;7264.455165862555;7269.236730143338;7356.337929586336;1623.8863279570435;1670.7493875918587;2000.6398848207316;2002.0390212697841;2009.9698504522444;2016.737824082867;2053.0966374795116;2063.0097553174487;2067.855250132491;2079.2722547108465;1967.8130577595105;1978.4855937456293;1989.2938007007522;2034.3388398770385;2047.7542694876636;1980.4553747719349;2005.7693365262962;2013.32553594546;2014.8891810950392;2021.9890054972514;2042.703807947854;2048.6414877396546;2052.5073982244303;2059.8867062311565;2069.8758074515576;7284.235155308669;7367.557946523172;7404.444666650023;7448.441366897504;7449.739259125905;4163.687723420756;4271.530131685512;4328.156009578133;4340.110277393127;4357.259265924768;2560.6799150106235;2666.5733482642686;2669.305980445079;2670.305720512661;2675.464907018604;710.3393843725333;789.8222899847545;821.3018933906192;839.7396806989852;850.3622283287534;9667.758306042335;9704.854427183598;9807.950960245225;9856.063673951036;9857.852132218022;3854.5952674969285;3930.9213815723524;3935.7244992850224;3976.6421022108148;3991.4611527444004;8413.411061225655;8462.788430289293;8505.53219572917;8519.105493923173;8621.568921554022;4332.935005974913;4359.629431498295;4408.316710909814;4415.867523974286;4421.668374871833;3910.2570511602703;3941.1723538056754;3959.8020098994934;3963.583823698528;4008.178323443687;3383.154211447138;3451.5685539307588;3461.549998500179;3489.8832373640194;3499.8775042873376;1087.798757229915;1091.1761619977026;1093.830456279278;1096.9890301097046;1099.1261946752352;1000.5097502223858;1013.7364285285731;1021.5607288865859;1107.5016242690822;1248.6815861955142;6841.3842754152365;6925.891857302908;6932.757353492603;6967;6993.720251189997;380.9809509524568;389.9902502437462;392.59758747284263;393.09587947720127;396.409350068396;5257.526822585985;5306.257124002643;5355.705436201047;5357.35711714589;5443.537299329522;7846.136924938252;7962.800929976797;8633.309335253165;8818.559072046372;8915.910840891638;8609.526476043879;8631.48211107323;8710.956445217733;8721.738347849574;8767;6563.245226798979;6606.966965165239;6645.235797883209;6718;6728.091707619409;6947.610477904541;6967.7212911485;7051.717931282691;7081.575105493687;7092.042574252616;7538.660760265691;7695.576743279174;7771.145174030739;7831.569263690324;7833.5691536966015;7810.10183828867;8025.036995560336;8038.799030024063;8061.314788243065;8088.757337279891;6509.730602532461;6525.412712855866;6550.6069635822005;6590.7693230736695;6608.735650574115;6789.15135608049;6948.756793512202;6965.199002114821;7039.612821294878;7077.469189810888;6521.380468855451;6599.373059559334;6626.768063117768;6649;6654.201495820533;6372.6495042773095;6409.679516024087;6419.871602568016;6593.505487088391;6598.736050557924;6590.736370545124;6609.735610575523;6619.040239165198;6655.068290439245;6691.799246022627;5964.701764911824;5982.1325907744;6015.428534289235;6088.269407671108;6103.145559621746;5761.452661997104;5926.111083337534;5931.08068249422;5973.820785376446;5979.103134529855 08:39:11 INFO - 2015-11-14 08:39:11,981 DEBUG : BROWSER_OUTPUT: |4;prototype.html;279.82790583790967;288.62478777589126;292.8140630699505;298.31834258718834;300.60020173169687;5696.857578560533;5809.912851307228;5836.6206196597195;5900.203472531212;5901.262342207224;5718.256626638531;5730.512906402951;5746.655200687951;5752.827415177541;5781.075027995522;4439.533848945863;4445.955540444603;4446.421965144526;4449.5105538390835;4469;4427.867163985069;4431.911361772763;4446.110777844444;4447.35513350564;4454.799534020977;4259.7231179973205;4398.912021759563;4409.691321607489;4417.889552761175;4457.754823484707;4366.497852746943;4380.036391993756;4390.078083602447;4391.2534869072015;4413.360062790877;3766.3785475396526;3802.8098595070414;3814.408766641175;3818.389057750774;3832.1952389997855;5556.583256255797;5565;5654.830355089354;5656.43435656431;5670.064439367499;4828.275758636198;4925.704457732511;4959.975200123977;4998.5751211146735;5002.199648056294;5972.731227094748;6032.517398608101;6038.245219347582;6041.758329666808;6048.697565121726;4107.219628270619;4149.33610622302;4153.501579810442;4159.521655009682;4162.646175075122;6056.5457590680435;6266.968665156691;6329.303776584572;6370.77702280418;6390.7763228286785;4145.108801607669;4244.957550424518;4250.723702959298;4259.488861336659;4262.168877068942;4260.829566817292;4290.764007979528;4295.355696645528;4306.547812479707;4327.415798867176;4780.139574876555;4855.223164293696;4889.926651100165;4909.7790599423115;4995.850124496271;6070.666113363719;6084.296397008845;6098.024316109401;6108;6123.357047510036;1510.3052595805832;1515.9242037898061;1530.8469153084825;1534.6547026918854;1535.5163123616026;989.9257555683353;1001.4291853643499;1005.9295849290626;1019.2202964731986;1022.9130523905402;5713;5859.20900678403;5914.467697907123;5914.467697907209;5916.349201587822;6297.023961286008;6334.3032266450655;6355.332690067568;6355.936440635627;6367.299597044322;5898.970505147447;5901.822945311647;5905.173275741399;5908;5910.1725758392995;3244.545763593099;3390.6439823818637;3447.0865220716532;3456.5333679953387;3459.187091033605;6540;6552.3775241352;6556.541042127101;6563.671816409256;6604.306547812506;6486.67566621667;6492.577982431127;6499.610023398611;6514.446272066927;6543.770968016097;6338.239411270585;6532.864225171944;6554.934450655528;6568.671566421755;6639.4024537790865;6365.204349456318;6375.971413578513;6377.2984971654005;6412.198475190601;6413.551051426355;6200.627962322275;6207.037909124093;6217.813465596039;6257.030160325156;6265.122882796321;6326.525510586816;6502.902456463063;6566.310537393505;6586.275509693834;6596.175478065242;4291.699581029298;4307.870763877088;4317.481902171759;4338.6312163466455;4355.0854320593035;6175.84560385976;6250.812475625738;6269.435750782452;6302.054691796267;6305.211848518935;6008.429199226067;6184.5980011299125;6213.539818142824;6230.158928544589;6258.186435763321;6160.537959652955;6167.167432396748;6168.1056246844855;6172.69136543162;6234.376562343729;5811.418858114154;5982.282126144716;6057.242844644419;6075.848103797441;6081.452669259788;6114.785982490592;6130.693465326626;6184.041473571604;6202.2867370253;6276.654783986742;6039.516838652985;6045.21412216409;6049.455549000435;6086.02623580225;6091.390860913873 08:39:11 INFO - 2015-11-14 08:39:11,982 DEBUG : BROWSER_OUTPUT: |5;yui.html;597.3578403216541;605.4127496328562;607.2474088139884;615.3016326469456;709.6629101176945;10106.292559520836;10362.378257304548;12885.806712899303;13034.21794692318;13053.282069486186;9742;12754.298513581749;13087.672808179777;13094.279814610192;13158.407871645775;637.5568979559208;811.1158836867828;829.6598394658191;832.3382910586068;843.4939036578065;647.7020570537559;794.8012996750813;843.3464065349342;847.3560094328293;852.1265702654797;853.15111464093;869.4956924983526;869.5087275689216;870.5908223135116;871.1419252036738;854.7521218846528;857.0615176381851;857.3012994409536;858.9570521473963;865.1435079271475;640.1517988665038;640.3596403596404;643.5655932245716;643.9581427207216;645.2386184302521;12419.006479481619;12586.748265034648;12587.370631468482;12657.30384828834;12731.172473789175;10578.047975682148;10621.628243011535;10846.132309415307;10854.45727713611;11019.338839669645;8610.225079742853;8779.20987111163;8826.955865220632;8873.866891996626;9306.86039709405;3022.425739109562;3118.3607360491046;3168.8098714077228;3172;3276.737860971117;43975.78012109919;44102.779486102365;44228;44313.77843110796;46035.30947035797;8217.83564328722;8349.916500834914;8458.915410845935;8557.743267701979;8846.646134154562;17475.650486990187;17477.300907963792;17516.737248941277;17601.823981760273;17699.20353584092;5734.283214598176;5812.767489300465;6028.125921741323;6029.517638588903;6060.151578778975;3382.2051817822794;3383.864645414156;3396.354692608446;3419.145213696576;3444.638312977101;2489.738577449342;2514.371407148213;2515.0442831723826;2515.7735803777746;2518.257114151293;422.72945314998424;425.3109961861804;436.0080816143299;442.3541629221373;443.7803287372771;460.900906305146;473.1884817537939;491.9311296418504;499.48552990419927;589.4694774702716;7271.381932535794;7708.306252437307;7714.1128770192145;7773.222677732295;7825.960870195727;477.73485715428274;543.9972800135974;551.0466892276385;551.6993238684927;611.5688439650125;3522.348365552381;3645.799481028569;3682.3739964206147;3689.1330537323706;3727.254549090193;54474;54914;55591.16613250804;55785.721071394386;55815.44184558102;47059.294110588366;47887.521124789004;48046.27930581044;48299.75850120727;48365.032699345815;41908.161836763094;41992.580074199475;42123;42123.368149477785;42151.156976860904;7489.588072656056;7674.769756907302;7781.144074151952;7844.686212551434;8134.552599607078;31946.36107277888;32006.51990220102;32207;32633.836830816643;32692.50961235631;40617;43215.56784432115;43478.347824782024;43770.56229437665;44292.33561496516;6903.654817259217;6995.720171193096;7048.118985126859;7166.912438723156;7280.344768970818;10069.949650251701;10209.795804084026;10343;10502.842457363298;10952.34285942846;9743.415395076318;9750.902490974999;9761;10046.095851373411;10314.329568578018;9387.342885997914;9859.112679858847;9985.750356241153;10020.048095430922;10337.483125843828;9647.372920760128;9717.076877696607;9873.506324683593;10000.799984000425;10171.7457063574;8016;8169.5098294102545;8553.82892342162;8581.098984606777;8865;7998.200179982188;8165.77513372975;8337.666493340199;8714.172153645393;8929.464232146092 08:39:11 INFO - 2015-11-14 08:39:11,982 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:39:11 INFO - 2015-11-14 08:39:11,982 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:39:11 INFO - 2015-11-14 08:39:11,982 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,974 08:39:11 INFO - 2015-11-14 08:39:11,982 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:39:11 INFO - 2015-11-14 08:39:11,983 DEBUG : BROWSER_OUTPUT: __startTimestamp1447519151969__endTimestamp 08:39:11 INFO - 2015-11-14 08:39:11,983 DEBUG : BROWSER_OUTPUT: 08:39:11 INFO - 2015-11-14 08:39:11,983 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:39:11 INFO - 2015-11-14 08:39:11,983 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:39:11 INFO - 2015-11-14 08:39:11,983 DEBUG : BROWSER_OUTPUT: 08:39:11 INFO - 2015-11-14 08:39:11,983 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4898.92 Median:5053.60 stddev:511.54 (10.1%) stddev-sans-first:489.60 08:39:11 INFO - 2015-11-14 08:39:11,985 DEBUG : BROWSER_OUTPUT: Values: 2944.7 2980.6 3058.9 3091.4 3153.0 4771.8 4776.7 4934.9 4958.8 5028.0 4896.3 4901.8 4904.2 4913.5 5066.9 4538.5 4581.8 4602.9 4633.7 4651.0 4596.1 4598.1 4660.2 4663.1 4669.0 4395.8 4440.6 4510.5 4528.7 4547.1 4561.2 4573.4 4590.7 4598.5 4612.2 4518.9 4537.3 4538.9 4570.2 4572.4 4696.4 4808.2 4811.2 4847.9 4888.0 5218.9 5220.7 5221.4 5221.4 5236.2 5290.3 5318.7 5329.4 5386.0 5409.5 4659.7 4742.9 4754.0 4780.4 4950.7 5357.4 5413.4 5419.1 5443.6 5454.2 5163.2 5166.9 5168.3 5176.4 5177.7 4981.8 5115.4 5132.9 5200.5 5314.2 5136.1 5137.6 5140.8 5155.2 5239.4 5169.0 5169.1 5188.3 5224.3 5286.2 3913.6 3976.4 4020.9 4032.5 4037.4 3677.3 3706.7 3718.2 3719.4 3731.3 4964.7 4967.7 4973.3 4986.3 4990.8 5075.6 5238.3 5294.6 5298.5 5319.7 4952.4 4986.9 4995.0 5015.4 5067.6 4674.6 4690.4 4706.2 4769.2 4773.9 5269.3 5318.9 5319.5 5361.5 5481.9 5334.5 5359.7 5367.1 5456.0 5472.3 5462.9 5528.1 5533.8 5547.2 5572.2 4948.1 5093.1 5100.5 5177.1 5261.4 5155.7 5184.0 5195.2 5218.6 5302.2 5053.6 5081.3 5082.6 5083.8 5119.3 4892.3 5017.4 5080.7 5104.9 5112.0 4957.4 5093.5 5098.8 5099.2 5121.9 5174.9 5175.6 5192.7 5229.5 5289.9 4828.6 4979.6 4984.7 5041.5 5134.9 08:39:11 INFO - 2015-11-14 08:39:11,985 DEBUG : BROWSER_OUTPUT: 08:39:11 INFO - 2015-11-14 08:39:11,985 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40963.58 Median:270309.50 stddev:65008.28 (24.0%) stddev-sans-first:65119.68 08:39:11 INFO - 2015-11-14 08:39:11,986 DEBUG : BROWSER_OUTPUT: Values: 509.3 512.3 523.9 531.0 543.6 28353.7 29625.0 36801.1 37201.6 38199.8 40291.4 40452.4 40886.4 40888.8 40937.4 7629.8 8591.0 8746.3 8746.7 8785.0 7411.5 9835.5 10214.1 10237.3 10278.2 10129.4 10292.5 10331.6 10338.9 10359.8 7796.4 8014.6 10268.1 10291.7 10354.7 9903.2 10154.1 10154.2 10165.2 10183.3 36762.6 37435.6 37785.0 37914.8 37928.4 2573.3 2686.6 2869.3 2907.0 3151.4 25939.5 26046.5 26245.7 26616.7 26737.5 2241.2 2248.9 2262.8 2282.2 2353.8 247098.0 250206.0 252756.0 253212.0 254714.0 53525.0 54581.2 58114.0 58544.0 58621.7 60980.7 61059.4 61430.4 61859.0 61862.7 13552.9 13675.2 13681.7 13821.4 13849.5 9978.4 10114.4 10137.2 10269.4 10275.2 18769.0 18886.3 19123.3 19137.7 19215.5 7369.5 7630.8 7678.3 7736.0 7737.1 854.8 910.2 992.6 1000.0 1048.3 26505.9 26717.2 26753.5 26893.7 26983.7 960.2 966.1 1009.2 1055.8 1059.0 12833.2 12876.5 13113.6 13125.5 13172.7 221165.0 225900.0 225957.0 226260.0 227320.0 51084.5 51649.0 51853.5 51952.2 52045.0 1268.1 1270.4 1280.7 1284.8 1288.9 24970.0 25509.4 25657.2 25794.4 25810.0 40165.4 40247.8 40331.4 40378.0 40465.6 265739.0 269127.0 269586.0 270229.0 270390.0 25662.7 25769.2 25944.8 26064.6 28813.4 30580.8 32881.0 33493.8 35309.3 39977.4 31938.5 32322.0 33198.0 33301.5 33524.3 32512.5 32559.0 33030.8 33078.7 33175.8 28799.4 29315.1 29375.0 34137.1 34699.8 25701.5 26712.6 28337.4 29110.9 29682.4 20924.5 21274.3 21455.6 22037.9 22268.2 08:39:11 INFO - 2015-11-14 08:39:11,986 DEBUG : BROWSER_OUTPUT: 08:39:11 INFO - 2015-11-14 08:39:11,986 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24601.03 Median:25006.91 stddev:76986.71 (307.9%) stddev-sans-first:77181.06 08:39:11 INFO - 2015-11-14 08:39:11,987 DEBUG : BROWSER_OUTPUT: Values: 306.8 307.9 310.7 312.1 312.7 13958.7 14305.1 14470.1 15972.2 16559.0 14313.9 16266.6 16347.3 16877.1 16996.4 4211.3 4894.0 4989.6 5053.8 5106.8 3620.3 3695.3 3745.6 4941.1 4988.3 5306.0 5328.3 5364.4 5449.2 5466.8 5321.6 5325.6 5417.3 5527.7 5554.8 4646.8 4651.2 4653.5 4704.9 4722.7 19368.0 19493.2 19755.1 19955.4 20007.2 1886.4 1890.9 1906.0 2105.2 2186.7 12021.6 12373.6 12386.6 12564.7 12895.9 1504.2 1541.8 1545.8 1563.2 1579.6 45925.0 48107.3 48385.5 48754.5 50068.7 5838.4 5923.9 5975.0 6003.2 6035.4 6847.2 6889.1 6905.4 6944.9 7012.6 4579.3 4596.9 4611.5 4654.0 4712.6 4655.6 4672.2 4698.6 4782.5 4794.7 2685.4 2691.4 2693.2 2704.9 2709.6 870.7 923.1 931.5 998.0 1002.2 389.8 421.1 421.8 437.4 438.0 10424.9 10768.7 10775.8 10813.7 10875.1 417.4 429.9 434.4 437.1 439.3 5755.1 5834.7 5891.0 5907.7 5980.7 429490.0 469116.0 480488.0 485892.0 489116.0 61305.7 61961.4 61995.0 62544.4 64113.0 451.5 466.1 466.9 470.1 471.7 9743.9 9795.6 9921.9 9976.5 10017.3 29849.7 29854.9 30090.0 30247.4 30882.1 43858.6 44964.6 45434.5 45873.3 48493.5 12871.6 13267.1 13682.9 13747.4 13852.9 16873.1 16937.1 17161.0 17204.3 17251.7 7647.6 7778.7 7903.2 8463.3 8585.6 8415.9 8492.6 8579.7 8623.6 8899.7 7621.1 7885.8 8016.3 8769.4 8909.4 13171.5 13198.1 13556.1 13580.5 13677.9 13813.2 13849.7 13868.0 13976.7 13989.7 08:39:11 INFO - 2015-11-14 08:39:11,987 DEBUG : BROWSER_OUTPUT: 08:39:11 INFO - 2015-11-14 08:39:11,987 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5042.45 Median:6387.46 stddev:2670.52 (41.8%) stddev-sans-first:2664.27 08:39:11 INFO - 2015-11-14 08:39:11,989 DEBUG : BROWSER_OUTPUT: Values: 1436.9 1618.3 1680.8 1697.7 1708.3 6402.3 6666.0 7026.4 7288.4 7310.9 7134.3 7231.8 7264.5 7269.2 7356.3 1623.9 1670.7 2000.6 2002.0 2010.0 2016.7 2053.1 2063.0 2067.9 2079.3 1967.8 1978.5 1989.3 2034.3 2047.8 1980.5 2005.8 2013.3 2014.9 2022.0 2042.7 2048.6 2052.5 2059.9 2069.9 7284.2 7367.6 7404.4 7448.4 7449.7 4163.7 4271.5 4328.2 4340.1 4357.3 2560.7 2666.6 2669.3 2670.3 2675.5 710.3 789.8 821.3 839.7 850.4 9667.8 9704.9 9808.0 9856.1 9857.9 3854.6 3930.9 3935.7 3976.6 3991.5 8413.4 8462.8 8505.5 8519.1 8621.6 4332.9 4359.6 4408.3 4415.9 4421.7 3910.3 3941.2 3959.8 3963.6 4008.2 3383.2 3451.6 3461.5 3489.9 3499.9 1087.8 1091.2 1093.8 1097.0 1099.1 1000.5 1013.7 1021.6 1107.5 1248.7 6841.4 6925.9 6932.8 6967.0 6993.7 381.0 390.0 392.6 393.1 396.4 5257.5 5306.3 5355.7 5357.4 5443.5 7846.1 7962.8 8633.3 8818.6 8915.9 8609.5 8631.5 8711.0 8721.7 8767.0 6563.2 6607.0 6645.2 6718.0 6728.1 6947.6 6967.7 7051.7 7081.6 7092.0 7538.7 7695.6 7771.1 7831.6 7833.6 7810.1 8025.0 8038.8 8061.3 8088.8 6509.7 6525.4 6550.6 6590.8 6608.7 6789.2 6948.8 6965.2 7039.6 7077.5 6521.4 6599.4 6626.8 6649.0 6654.2 6372.6 6409.7 6419.9 6593.5 6598.7 6590.7 6609.7 6619.0 6655.1 6691.8 5964.7 5982.1 6015.4 6088.3 6103.1 5761.5 5926.1 5931.1 5973.8 5979.1 08:39:11 INFO - 2015-11-14 08:39:11,989 DEBUG : BROWSER_OUTPUT: 08:39:11 INFO - 2015-11-14 08:39:11,989 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5106.58 Median:5899.59 stddev:1559.69 (26.4%) stddev-sans-first:1521.40 08:39:11 INFO - 2015-11-14 08:39:11,990 DEBUG : BROWSER_OUTPUT: Values: 279.8 288.6 292.8 298.3 300.6 5696.9 5809.9 5836.6 5900.2 5901.3 5718.3 5730.5 5746.7 5752.8 5781.1 4439.5 4446.0 4446.4 4449.5 4469.0 4427.9 4431.9 4446.1 4447.4 4454.8 4259.7 4398.9 4409.7 4417.9 4457.8 4366.5 4380.0 4390.1 4391.3 4413.4 3766.4 3802.8 3814.4 3818.4 3832.2 5556.6 5565.0 5654.8 5656.4 5670.1 4828.3 4925.7 4960.0 4998.6 5002.2 5972.7 6032.5 6038.2 6041.8 6048.7 4107.2 4149.3 4153.5 4159.5 4162.6 6056.5 6267.0 6329.3 6370.8 6390.8 4145.1 4245.0 4250.7 4259.5 4262.2 4260.8 4290.8 4295.4 4306.5 4327.4 4780.1 4855.2 4889.9 4909.8 4995.9 6070.7 6084.3 6098.0 6108.0 6123.4 1510.3 1515.9 1530.8 1534.7 1535.5 989.9 1001.4 1005.9 1019.2 1022.9 5713.0 5859.2 5914.5 5914.5 5916.3 6297.0 6334.3 6355.3 6355.9 6367.3 5899.0 5901.8 5905.2 5908.0 5910.2 3244.5 3390.6 3447.1 3456.5 3459.2 6540.0 6552.4 6556.5 6563.7 6604.3 6486.7 6492.6 6499.6 6514.4 6543.8 6338.2 6532.9 6554.9 6568.7 6639.4 6365.2 6376.0 6377.3 6412.2 6413.6 6200.6 6207.0 6217.8 6257.0 6265.1 6326.5 6502.9 6566.3 6586.3 6596.2 4291.7 4307.9 4317.5 4338.6 4355.1 6175.8 6250.8 6269.4 6302.1 6305.2 6008.4 6184.6 6213.5 6230.2 6258.2 6160.5 6167.2 6168.1 6172.7 6234.4 5811.4 5982.3 6057.2 6075.8 6081.5 6114.8 6130.7 6184.0 6202.3 6276.7 6039.5 6045.2 6049.5 6086.0 6091.4 08:39:11 INFO - 2015-11-14 08:39:11,990 DEBUG : BROWSER_OUTPUT: 08:39:11 INFO - 2015-11-14 08:39:11,991 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12555.96 Median:27509.00 stddev:15100.31 (54.9%) stddev-sans-first:15115.97 08:39:11 INFO - 2015-11-14 08:39:11,992 DEBUG : BROWSER_OUTPUT: Values: 597.4 605.4 607.2 615.3 709.7 10106.3 10362.4 12885.8 13034.2 13053.3 9742.0 12754.3 13087.7 13094.3 13158.4 637.6 811.1 829.7 832.3 843.5 647.7 794.8 843.3 847.4 852.1 853.2 869.5 869.5 870.6 871.1 854.8 857.1 857.3 859.0 865.1 640.2 640.4 643.6 644.0 645.2 12419.0 12586.7 12587.4 12657.3 12731.2 10578.0 10621.6 10846.1 10854.5 11019.3 8610.2 8779.2 8827.0 8873.9 9306.9 3022.4 3118.4 3168.8 3172.0 3276.7 43975.8 44102.8 44228.0 44313.8 46035.3 8217.8 8349.9 8458.9 8557.7 8846.6 17475.7 17477.3 17516.7 17601.8 17699.2 5734.3 5812.8 6028.1 6029.5 6060.2 3382.2 3383.9 3396.4 3419.1 3444.6 2489.7 2514.4 2515.0 2515.8 2518.3 422.7 425.3 436.0 442.4 443.8 460.9 473.2 491.9 499.5 589.5 7271.4 7708.3 7714.1 7773.2 7826.0 477.7 544.0 551.0 551.7 611.6 3522.3 3645.8 3682.4 3689.1 3727.3 54474.0 54914.0 55591.2 55785.7 55815.4 47059.3 47887.5 48046.3 48299.8 48365.0 41908.2 41992.6 42123.0 42123.4 42151.2 7489.6 7674.8 7781.1 7844.7 8134.6 31946.4 32006.5 32207.0 32633.8 32692.5 40617.0 43215.6 43478.3 43770.6 44292.3 6903.7 6995.7 7048.1 7166.9 7280.3 10069.9 10209.8 10343.0 10502.8 10952.3 9743.4 9750.9 9761.0 10046.1 10314.3 9387.3 9859.1 9985.8 10020.0 10337.5 9647.4 9717.1 9873.5 10000.8 10171.7 8016.0 8169.5 8553.8 8581.1 8865.0 7998.2 8165.8 8337.7 8714.2 8929.5 08:39:11 INFO - 2015-11-14 08:39:11,992 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:39:11 INFO - 2015-11-14 08:39:11,992 DEBUG : BROWSER_OUTPUT: 08:39:12 INFO - 2015-11-14 08:39:12,671 INFO : Browser exited with error code: 0 08:39:12 INFO - 2015-11-14 08:39:12,701 INFO : Completed test dromaeo_css (00:18:36) 08:39:12 INFO - 2015-11-14 08:39:12,701 INFO : Starting test kraken 08:39:12 INFO - 2015-11-14 08:39:12,701 DEBUG : operating with platform_type : mac_ 08:39:12 INFO - 2015-11-14 08:39:12,701 INFO : Initialising browser for kraken test... 08:39:12 INFO - 2015-11-14 08:39:12,716 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmpH3Ym20/profile http://localhost:49263/getInfo.html 08:39:15 INFO - 2015-11-14 08:39:15,069 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:39:15 INFO - 2015-11-14 08:39:15,070 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:39:15 INFO - 2015-11-14 08:39:15,070 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:39:15 INFO - 2015-11-14 08:39:15,070 DEBUG : BROWSER_OUTPUT: __metrics 08:39:15 INFO - 2015-11-14 08:39:15,087 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:39:15 INFO - 2015-11-14 08:39:15,842 INFO : Browser initialized. 08:39:15 INFO - 2015-11-14 08:39:15,843 INFO : Running cycle 1/1 for kraken test... 08:39:15 INFO - 2015-11-14 08:39:15,843 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmpH3Ym20/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:39:27 INFO - 2015-11-14 08:39:27,830 DEBUG : BROWSER_OUTPUT: RSS: Main: 229322752 08:39:27 INFO - 2015-11-14 08:39:27,831 DEBUG : BROWSER_OUTPUT: 08:39:30 INFO - 2015-11-14 08:39:30,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection) 08:39:30 INFO - 2015-11-14 08:39:30,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 285687808 08:39:30 INFO - 2015-11-14 08:39:30,987 DEBUG : BROWSER_OUTPUT: 08:39:33 INFO - 2015-11-14 08:39:33,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-dft) 08:39:34 INFO - 2015-11-14 08:39:34,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 299610112 08:39:34 INFO - 2015-11-14 08:39:34,307 DEBUG : BROWSER_OUTPUT: 08:39:37 INFO - 2015-11-14 08:39:37,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-fft) 08:39:37 INFO - 2015-11-14 08:39:37,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 281751552 08:39:37 INFO - 2015-11-14 08:39:37,973 DEBUG : BROWSER_OUTPUT: 08:39:40 INFO - 2015-11-14 08:39:40,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator) 08:39:40 INFO - 2015-11-14 08:39:40,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 283906048 08:39:40 INFO - 2015-11-14 08:39:40,650 DEBUG : BROWSER_OUTPUT: 08:39:42 INFO - 2015-11-14 08:39:42,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:39:43 INFO - 2015-11-14 08:39:43,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 283787264 08:39:43 INFO - 2015-11-14 08:39:43,483 DEBUG : BROWSER_OUTPUT: 08:39:46 INFO - 2015-11-14 08:39:46,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom) 08:39:47 INFO - 2015-11-14 08:39:47,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 284020736 08:39:47 INFO - 2015-11-14 08:39:47,259 DEBUG : BROWSER_OUTPUT: 08:39:50 INFO - 2015-11-14 08:39:50,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate) 08:39:51 INFO - 2015-11-14 08:39:51,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 284528640 08:39:51 INFO - 2015-11-14 08:39:51,158 DEBUG : BROWSER_OUTPUT: 08:39:54 INFO - 2015-11-14 08:39:54,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial) 08:39:54 INFO - 2015-11-14 08:39:54,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 283918336 08:39:54 INFO - 2015-11-14 08:39:54,758 DEBUG : BROWSER_OUTPUT: 08:39:56 INFO - 2015-11-14 08:39:56,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:39:56 INFO - 2015-11-14 08:39:56,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 319135744 08:39:56 INFO - 2015-11-14 08:39:56,953 DEBUG : BROWSER_OUTPUT: 08:39:58 INFO - 2015-11-14 08:39:58,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:39:59 INFO - 2015-11-14 08:39:59,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 319045632 08:39:59 INFO - 2015-11-14 08:39:59,440 DEBUG : BROWSER_OUTPUT: 08:40:01 INFO - 2015-11-14 08:40:01,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:40:02 INFO - 2015-11-14 08:40:02,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 328806400 08:40:02 INFO - 2015-11-14 08:40:02,224 DEBUG : BROWSER_OUTPUT: 08:40:04 INFO - 2015-11-14 08:40:04,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:40:05 INFO - 2015-11-14 08:40:05,557 DEBUG : BROWSER_OUTPUT: RSS: Main: 329035776 08:40:05 INFO - 2015-11-14 08:40:05,557 DEBUG : BROWSER_OUTPUT: 08:40:08 INFO - 2015-11-14 08:40:08,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:40:08 INFO - 2015-11-14 08:40:08,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 329019392 08:40:08 INFO - 2015-11-14 08:40:08,870 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49263/tests/kraken/driver.html?testName=ai-astar) 08:40:10 INFO - 2015-11-14 08:40:10,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 387899392 08:40:10 INFO - 2015-11-14 08:40:10,920 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,920 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:40:10 INFO - 2015-11-14 08:40:10,920 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:40:10 INFO - 2015-11-14 08:40:10,920 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:40:10 INFO - 2015-11-14 08:40:10,920 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:40:10 INFO - 2015-11-14 08:40:10,921 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;105;109;109;109;108;111;100;110 08:40:10 INFO - 2015-11-14 08:40:10,921 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;136;158;167;125;156;159;138;183;142 08:40:10 INFO - 2015-11-14 08:40:10,921 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;170;172;174;175;175;175;173;172 08:40:10 INFO - 2015-11-14 08:40:10,921 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;80;93;89;73;75;78;94;93;72 08:40:10 INFO - 2015-11-14 08:40:10,921 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;102;99;138;93;95;95;139;96;95;142 08:40:10 INFO - 2015-11-14 08:40:10,921 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;123;125;128;134;129;129;123;123;130;136 08:40:10 INFO - 2015-11-14 08:40:10,921 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;129;131;136;141;138;135;136;136;137;141 08:40:10 INFO - 2015-11-14 08:40:10,922 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;101;110;104;104;113;109;108;105;113;113 08:40:10 INFO - 2015-11-14 08:40:10,922 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;59;60;61;63;63;73;62;66 08:40:10 INFO - 2015-11-14 08:40:10,922 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;66;70;70;70;77;73;74;73;73 08:40:10 INFO - 2015-11-14 08:40:10,922 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;94;88;94;92;96;95;96;92;94;93 08:40:10 INFO - 2015-11-14 08:40:10,922 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;140;149;137;149;141;138;137;147;142 08:40:10 INFO - 2015-11-14 08:40:10,923 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;156;160;155;154;171;167;155;171;174;160 08:40:10 INFO - 2015-11-14 08:40:10,923 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;72;73;73;73;76;77;79;76;77 08:40:10 INFO - 2015-11-14 08:40:10,923 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:40:10 INFO - 2015-11-14 08:40:10,923 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:40:10 INFO - 2015-11-14 08:40:10,923 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,921 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: __startTimestamp1447519210914__endTimestamp 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:3.31 (3.0%) stddev-sans-first:3.50 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 105.0 109.0 109.0 109.0 108.0 111.0 100.0 110.0 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:152.00 Median:157.00 stddev:16.94 (10.8%) stddev-sans-first:17.91 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: Values: 156.0 136.0 158.0 167.0 125.0 156.0 159.0 138.0 183.0 142.0 08:40:10 INFO - 2015-11-14 08:40:10,924 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:170.80 Median:173.50 stddev:5.43 (3.1%) stddev-sans-first:4.74 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 170.0 172.0 174.0 175.0 175.0 175.0 173.0 172.0 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.40 Median:84.50 stddev:8.87 (10.5%) stddev-sans-first:9.19 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: Values: 77.0 80.0 93.0 89.0 73.0 75.0 78.0 94.0 93.0 72.0 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:109.40 Median:95.00 stddev:21.06 (22.2%) stddev-sans-first:22.16 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: Values: 102.0 99.0 138.0 93.0 95.0 95.0 139.0 96.0 95.0 142.0 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:128.00 Median:129.00 stddev:4.59 (3.6%) stddev-sans-first:4.50 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: Values: 123.0 125.0 128.0 134.0 129.0 129.0 123.0 123.0 130.0 136.0 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:136.00 Median:136.50 stddev:3.80 (2.8%) stddev-sans-first:3.07 08:40:10 INFO - 2015-11-14 08:40:10,925 DEBUG : BROWSER_OUTPUT: Values: 129.0 131.0 136.0 141.0 138.0 135.0 136.0 136.0 137.0 141.0 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:108.00 Median:109.50 stddev:4.35 (4.0%) stddev-sans-first:3.80 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: Values: 101.0 110.0 104.0 104.0 113.0 109.0 108.0 105.0 113.0 113.0 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.40 Median:62.50 stddev:4.43 (7.1%) stddev-sans-first:4.52 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 59.0 60.0 61.0 63.0 63.0 73.0 62.0 66.0 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:73.00 stddev:3.33 (4.6%) stddev-sans-first:3.15 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 70.0 70.0 70.0 77.0 73.0 74.0 73.0 73.0 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:93.40 Median:94.00 stddev:2.37 (2.5%) stddev-sans-first:2.50 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: Values: 94.0 88.0 94.0 92.0 96.0 95.0 96.0 92.0 94.0 93.0 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,926 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:141.50 stddev:5.84 (4.1%) stddev-sans-first:4.92 08:40:10 INFO - 2015-11-14 08:40:10,927 DEBUG : BROWSER_OUTPUT: Values: 131.0 140.0 149.0 137.0 149.0 141.0 138.0 137.0 147.0 142.0 08:40:10 INFO - 2015-11-14 08:40:10,927 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,927 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:163.50 stddev:7.72 (4.7%) stddev-sans-first:7.84 08:40:10 INFO - 2015-11-14 08:40:10,927 DEBUG : BROWSER_OUTPUT: Values: 156.0 160.0 155.0 154.0 171.0 167.0 155.0 171.0 174.0 160.0 08:40:10 INFO - 2015-11-14 08:40:10,927 DEBUG : BROWSER_OUTPUT: 08:40:10 INFO - 2015-11-14 08:40:10,927 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:76.00 stddev:2.80 (3.7%) stddev-sans-first:2.42 08:40:10 INFO - 2015-11-14 08:40:10,927 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 73.0 73.0 73.0 76.0 77.0 79.0 76.0 77.0 08:40:10 INFO - 2015-11-14 08:40:10,927 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:40:10 INFO - 2015-11-14 08:40:10,927 DEBUG : BROWSER_OUTPUT: 08:40:11 INFO - 2015-11-14 08:40:11,601 INFO : Browser exited with error code: 0 08:40:11 INFO - 2015-11-14 08:40:11,651 INFO : Completed test kraken (00:00:58) 08:40:11 INFO - 2015-11-14 08:40:11,652 INFO : Starting test v8_7 08:40:11 INFO - 2015-11-14 08:40:11,652 DEBUG : operating with platform_type : mac_ 08:40:11 INFO - 2015-11-14 08:40:11,652 INFO : Initialising browser for v8_7 test... 08:40:11 INFO - 2015-11-14 08:40:11,665 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmpFTLbmZ/profile http://localhost:49263/getInfo.html 08:40:13 INFO - 2015-11-14 08:40:13,926 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:40:13 INFO - 2015-11-14 08:40:13,927 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:40:13 INFO - 2015-11-14 08:40:13,927 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 08:40:13 INFO - 2015-11-14 08:40:13,927 DEBUG : BROWSER_OUTPUT: __metrics 08:40:13 INFO - 2015-11-14 08:40:13,942 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:40:14 INFO - 2015-11-14 08:40:14,653 INFO : Browser initialized. 08:40:14 INFO - 2015-11-14 08:40:14,653 INFO : Running cycle 1/1 for v8_7 test... 08:40:14 INFO - 2015-11-14 08:40:14,653 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/T/tmpFTLbmZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:40:26 INFO - 2015-11-14 08:40:26,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 230367232 08:40:26 INFO - 2015-11-14 08:40:26,600 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49263/tests/v8_7/run.html (next: http://localhost:49263/tests/v8_7/run.html) 08:40:48 INFO - 2015-11-14 08:40:48,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 699641856 08:40:48 INFO - 2015-11-14 08:40:48,416 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,416 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:40:48 INFO - 2015-11-14 08:40:48,416 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:40:48 INFO - 2015-11-14 08:40:48,417 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:40:48 INFO - 2015-11-14 08:40:48,417 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:40:48 INFO - 2015-11-14 08:40:48,417 DEBUG : BROWSER_OUTPUT: |0;Richards;174.06440382941688 08:40:48 INFO - 2015-11-14 08:40:48,417 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;203.00446609825417 08:40:48 INFO - 2015-11-14 08:40:48,417 DEBUG : BROWSER_OUTPUT: |2;Encrypt;348.6750348675035 08:40:48 INFO - 2015-11-14 08:40:48,418 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6134.9693251533745 08:40:48 INFO - 2015-11-14 08:40:48,418 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2047.034764826176 08:40:48 INFO - 2015-11-14 08:40:48,418 DEBUG : BROWSER_OUTPUT: |5;Earley;1032.6732673267327 08:40:48 INFO - 2015-11-14 08:40:48,418 DEBUG : BROWSER_OUTPUT: |6;Boyer;13986.111111111111 08:40:48 INFO - 2015-11-14 08:40:48,418 DEBUG : BROWSER_OUTPUT: |7;RegExp;31500 08:40:48 INFO - 2015-11-14 08:40:48,418 DEBUG : BROWSER_OUTPUT: |8;Splay;643.915003219575 08:40:48 INFO - 2015-11-14 08:40:48,418 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6115.8536585365855 08:40:48 INFO - 2015-11-14 08:40:48,418 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:40:48 INFO - 2015-11-14 08:40:48,419 DEBUG : BROWSER_OUTPUT: __startTimestamp1447519248415__endTimestamp 08:40:48 INFO - 2015-11-14 08:40:48,419 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,419 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:40:48 INFO - 2015-11-14 08:40:48,419 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:40:48 INFO - 2015-11-14 08:40:48,419 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,420 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:174.06 Median:174.06 stddev:0.00 (0.0%) 08:40:48 INFO - 2015-11-14 08:40:48,420 DEBUG : BROWSER_OUTPUT: Values: 174.1 08:40:48 INFO - 2015-11-14 08:40:48,420 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,420 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:203.00 Median:203.00 stddev:0.00 (0.0%) 08:40:48 INFO - 2015-11-14 08:40:48,420 DEBUG : BROWSER_OUTPUT: Values: 203.0 08:40:48 INFO - 2015-11-14 08:40:48,421 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,421 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:348.68 Median:348.68 stddev:0.00 (0.0%) 08:40:48 INFO - 2015-11-14 08:40:48,421 DEBUG : BROWSER_OUTPUT: Values: 348.7 08:40:48 INFO - 2015-11-14 08:40:48,421 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,422 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6134.97 Median:6134.97 stddev:0.00 (0.0%) 08:40:48 INFO - 2015-11-14 08:40:48,422 DEBUG : BROWSER_OUTPUT: Values: 6135.0 08:40:48 INFO - 2015-11-14 08:40:48,422 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,422 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2047.03 Median:2047.03 stddev:0.00 (0.0%) 08:40:48 INFO - 2015-11-14 08:40:48,422 DEBUG : BROWSER_OUTPUT: Values: 2047.0 08:40:48 INFO - 2015-11-14 08:40:48,422 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,423 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1032.67 Median:1032.67 stddev:0.00 (0.0%) 08:40:48 INFO - 2015-11-14 08:40:48,423 DEBUG : BROWSER_OUTPUT: Values: 1032.7 08:40:48 INFO - 2015-11-14 08:40:48,423 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,423 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13986.11 Median:13986.11 stddev:0.00 (0.0%) 08:40:48 INFO - 2015-11-14 08:40:48,423 DEBUG : BROWSER_OUTPUT: Values: 13986.1 08:40:48 INFO - 2015-11-14 08:40:48,423 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,423 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:31500.00 Median:31500.00 stddev:0.00 (0.0%) 08:40:48 INFO - 2015-11-14 08:40:48,424 DEBUG : BROWSER_OUTPUT: Values: 31500.0 08:40:48 INFO - 2015-11-14 08:40:48,424 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,424 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:643.92 Median:643.92 stddev:0.00 (0.0%) 08:40:48 INFO - 2015-11-14 08:40:48,424 DEBUG : BROWSER_OUTPUT: Values: 643.9 08:40:48 INFO - 2015-11-14 08:40:48,424 DEBUG : BROWSER_OUTPUT: 08:40:48 INFO - 2015-11-14 08:40:48,424 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6115.85 Median:6115.85 stddev:0.00 (0.0%) 08:40:48 INFO - 2015-11-14 08:40:48,426 DEBUG : BROWSER_OUTPUT: Values: 6115.9 08:40:48 INFO - 2015-11-14 08:40:48,426 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:40:48 INFO - 2015-11-14 08:40:48,426 DEBUG : BROWSER_OUTPUT: 08:40:49 INFO - 2015-11-14 08:40:49,127 INFO : Browser exited with error code: 0 08:40:49 INFO - 2015-11-14 08:40:49,149 INFO : Completed test v8_7 (00:00:37) 08:40:49 INFO - 2015-11-14 08:40:49,470 INFO : Completed test suite (00:20:12) 08:40:49 INFO - 2015-11-14 08:40:49,470 DEBUG : Working with test: dromaeo_css 08:40:49 INFO - 2015-11-14 08:40:49,470 DEBUG : Generating results file: dromaeo_css 08:40:49 INFO - 2015-11-14 08:40:49,470 DEBUG : Working with test: kraken 08:40:49 INFO - 2015-11-14 08:40:49,471 DEBUG : Generating results file: kraken 08:40:49 INFO - 2015-11-14 08:40:49,471 INFO : javascript benchmark 08:40:49 INFO - 2015-11-14 08:40:49,471 DEBUG : Working with test: v8_7 08:40:49 INFO - 2015-11-14 08:40:49,471 DEBUG : Generating results file: v8_7 08:40:49 INFO - 2015-11-14 08:40:49,471 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:40:49 INFO - 2015-11-14 08:40:49,526 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,55]] 08:40:49 INFO - 2015-11-14 08:40:49,526 DEBUG : process_Request line: dromaeo_css 6215.49 graph.html#tests=[[72,64,55]] 08:40:49 INFO - 2015-11-14 08:40:49,526 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:40:49 INFO - 2015-11-14 08:40:49,558 DEBUG : process_Request line: kraken 1599.80 graph.html#tests=[[232,64,55]] 08:40:49 INFO - 2015-11-14 08:40:49,558 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:40:49 INFO - 2015-11-14 08:40:49,590 DEBUG : process_Request line: v8_7 17195.24 graph.html#tests=[[230,64,55]] 08:40:49 INFO - 2015-11-14 08:40:49,591 INFO : javascript benchmark 08:40:49 INFO - 2015-11-14 08:40:49,593 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [306.7591940326844, 307.8953155926984, 310.7420840702219, 312.05914168781123, 312.6576398843267, 13958.651033724162, 14305.141691498491, 14470.059446136007, 15972.2013899305, 16559.0, 14313.928430357833, 16266.593335166597, 16347.26437310321, 16877.07176105317, 16996.4051258206, 4211.284081706102, 4893.951060489385, 4989.575886049672, 5053.823116190934, 5106.770195341219, 3620.3302389057976, 3695.2794205130012, 3745.644163804448, 4941.135301322254, 4988.2766998785155, 5306.0, 5328.307320048408, 5364.409914909357, 5449.209864569635, 5466.753996070166, 5321.627486075957, 5325.627206095575, 5417.26866872971, 5527.695976721278, 5554.805581804638, 4646.814127434898, 4651.186042442559, 4653.48761652461, 4704.905901881977, 4722.716637001791, 19368.0, 19493.220271189137, 19755.111020004133, 19955.401337959884, 20007.1997120115, 1886.352704317688, 1890.914908829106, 1905.9809401905943, 2105.1684584589157, 2186.7157269554855, 12021.639350819489, 12373.566925157576, 12386.5664701735, 12564.748705025848, 12895.935520322339, 1504.2178067404998, 1541.7764424158547, 1545.7526795712745, 1563.2340153324903, 1579.5656194546477, 45925.0, 48107.27839082381, 48385.51614483845, 48754.51245487571, 50068.74965625185, 5838.38696936824, 5923.911141332884, 5975.043992961192, 6003.189569408074, 6035.39646035393, 6847.1783385994, 6889.069975553236, 6905.447564194852, 6944.895826562605, 7012.5792452453015, 4579.267317229227, 4596.908061838744, 4611.538846115429, 4654.0, 4712.5994290485005, 4655.627549796008, 4672.159011377917, 4698.600618947359, 4782.497837727058, 4794.7362895040405, 2685.368938299498, 2691.4078902641386, 2693.192042387276, 2704.8647567621933, 2709.593560965871, 870.6517393042707, 923.1045885491063, 931.5435436636135, 997.9501024948869, 1002.2282842211602, 389.795357437342, 421.1030505024279, 421.80386120454136, 437.35053445633207, 437.964962802975, 10424.895751042544, 10768.676939691823, 10775.83836242457, 10813.67558973232, 10875.129989600813, 417.353102690828, 429.8925268682829, 434.4070343980444, 437.10611798871383, 439.34318194299726, 5755.050416681201, 5834.708264586839, 5891.027980383275, 5907.734151963172, 5980.700964951735, 429490.0, 469116.0, 480488.0, 485892.0, 489116.0, 61305.693471533246, 61961.38038619556, 61995.0, 62544.37455625476, 64113.0, 451.4988362917159, 466.05158502448035, 466.8856130248111, 470.1067970855402, 471.7004702014246, 9743.853842192231, 9795.559199836167, 9921.851172232567, 9976.50117494137, 10017.298789084694, 29849.70150298556, 29854.850725747103, 30090.0, 30247.395052098396, 30882.0735377939, 43858.56141438672, 44964.55035449735, 45434.54565454303, 45873.311900320856, 48493.51506485031, 12871.613851584467, 13267.137636053625, 13682.931585342409, 13747.381367838272, 13852.861471385157, 16873.07198104116, 16937.06846123426, 17161.0, 17204.31182752676, 17251.65496690034, 7647.617619119133, 7778.727744528915, 7903.209679032281, 8463.322934165375, 8585.570721464026, 8415.8737618937, 8492.575371231538, 8579.65681372738, 8623.611937462703, 8899.688510902088, 7621.12357078943, 7885.763427097197, 8016.278534931884, 8769.38614296993, 8909.420887642282, 13171.538996135472, 13198.14212076212, 13556.051076424556, 13580.524681636096, 13677.931610341884, 13813.171209727449, 13849.723005540034, 13868.0, 13976.650583735487, 13989.720205596035], "dojo.html": [2944.6908074652147, 2980.5976193213924, 3058.8929387471444, 3091.412631599996, 3153.0068028571, 4771.785269662865, 4776.71339719617, 4934.8766280843, 4958.826441074563, 5028.0, 4896.314515967767, 4901.754912254391, 4904.239842824368, 4913.508649135094, 5066.873328166797, 4538.455385353762, 4581.816727330903, 4602.930956035662, 4633.698809577367, 4651.0, 4596.149712303235, 4598.080383923212, 4660.1844677181525, 4663.090697314025, 4669.042846216517, 4395.758233297167, 4440.622547083502, 4510.526394728539, 4528.660350473728, 4547.113312903985, 4561.156186105581, 4573.382593349888, 4590.678652494326, 4598.4711758147905, 4612.192866248393, 4518.887027824298, 4537.274036154233, 4538.8865278367975, 4570.223062079454, 4572.382728331666, 4696.436427628672, 4808.182608956486, 4811.182099043171, 4847.927281090787, 4888.046830867982, 5218.947810521884, 5220.686758794446, 5221.373435187802, 5221.425643179247, 5236.188390799394, 5290.259363689087, 5318.707471089088, 5329.360476742816, 5385.976664433784, 5409.459054094559, 4659.697119687209, 4742.928856067162, 4754.0, 4780.426348838162, 4950.702957822542, 5357.383900851374, 5413.431589683105, 5419.078756611386, 5443.591730620219, 5454.209139674805, 5163.225516172604, 5166.870828229325, 5168.250603662448, 5176.404713457925, 5177.741112944338, 4981.800727970841, 5115.411727651293, 5132.948670513247, 5200.479952004845, 5314.229436731653, 5136.101182293159, 5137.614678899097, 5140.768665409991, 5155.226715992631, 5239.423663397023, 5169.017886601534, 5169.095408303532, 5188.273641690166, 5224.346956630421, 5286.20706893969, 3913.62820532049, 3976.4234186042863, 4020.8994775130273, 4032.4556184915245, 4037.37420699792, 3677.3196958562216, 3706.703463722896, 3718.2377612589353, 3719.4420836874683, 3731.3470142724914, 4964.726940018261, 4967.677100988496, 4973.303737476756, 4986.252062190628, 4990.8253211137435, 5075.593952483792, 5238.292830467914, 5294.602904782157, 5298.549623282064, 5319.707416092075, 4952.380952380952, 4986.8753281168265, 4994.950050499521, 5015.398152221684, 5067.569256613229, 4674.555917187861, 4690.390249267573, 4706.1528924793865, 4769.165396055676, 4773.856784296477, 5269.288646032813, 5318.946810531846, 5319.521243088141, 5361.490658387447, 5481.945180548223, 5334.493223143795, 5359.705216213146, 5367.114426119647, 5456.0, 5472.261244731911, 5462.9180562292395, 5528.06022976103, 5533.806316778893, 5547.223388725501, 5572.192032155396, 4948.05986862495, 5093.108705976513, 5100.515451032146, 5177.068127737043, 5261.421243663118, 5155.742212889266, 5183.98912212115, 5195.246689229964, 5218.608604354613, 5302.151655735064, 5053.595712343077, 5081.263216833612, 5082.618803589819, 5083.822066227664, 5119.334486516878, 4892.315075889307, 5017.397912250553, 5080.669756465818, 5104.9489505104475, 5112.0, 4957.355543779286, 5093.490650935025, 5098.79604815818, 5099.184130539096, 5121.923171152361, 5174.948250517597, 5175.585953123817, 5192.749070234029, 5229.529342359206, 5289.894202116013, 4828.565429111397, 4979.576735977483, 4984.700917944935, 5041.546260836542, 5134.948650513447], "mootools.html": [1436.942522299108, 1618.3122173076442, 1680.8487236148744, 1697.6604679064183, 1708.333749837563, 6402.263739669934, 6665.966670166648, 7026.367626913577, 7288.416926645868, 7310.926890731104, 7134.322239387263, 7231.819204519877, 7264.455165862555, 7269.236730143338, 7356.337929586336, 1623.8863279570435, 1670.7493875918587, 2000.6398848207316, 2002.0390212697841, 2009.9698504522444, 2016.737824082867, 2053.0966374795116, 2063.0097553174487, 2067.855250132491, 2079.2722547108465, 1967.8130577595105, 1978.4855937456293, 1989.2938007007522, 2034.3388398770385, 2047.7542694876636, 1980.4553747719349, 2005.7693365262962, 2013.32553594546, 2014.8891810950392, 2021.9890054972514, 2042.703807947854, 2048.6414877396546, 2052.5073982244303, 2059.8867062311565, 2069.8758074515576, 7284.235155308669, 7367.557946523172, 7404.444666650023, 7448.441366897504, 7449.739259125905, 4163.687723420756, 4271.530131685512, 4328.156009578133, 4340.110277393127, 4357.259265924768, 2560.6799150106235, 2666.5733482642686, 2669.305980445079, 2670.305720512661, 2675.464907018604, 710.3393843725333, 789.8222899847545, 821.3018933906192, 839.7396806989852, 850.3622283287534, 9667.758306042335, 9704.854427183598, 9807.950960245225, 9856.063673951036, 9857.852132218022, 3854.5952674969285, 3930.9213815723524, 3935.7244992850224, 3976.6421022108148, 3991.4611527444004, 8413.411061225655, 8462.788430289293, 8505.53219572917, 8519.105493923173, 8621.568921554022, 4332.935005974913, 4359.629431498295, 4408.316710909814, 4415.867523974286, 4421.668374871833, 3910.2570511602703, 3941.1723538056754, 3959.8020098994934, 3963.583823698528, 4008.178323443687, 3383.154211447138, 3451.5685539307588, 3461.549998500179, 3489.8832373640194, 3499.8775042873376, 1087.798757229915, 1091.1761619977026, 1093.830456279278, 1096.9890301097046, 1099.1261946752352, 1000.5097502223858, 1013.7364285285731, 1021.5607288865859, 1107.5016242690822, 1248.6815861955142, 6841.3842754152365, 6925.891857302908, 6932.757353492603, 6967.0, 6993.720251189997, 380.9809509524568, 389.9902502437462, 392.59758747284263, 393.09587947720127, 396.409350068396, 5257.526822585985, 5306.257124002643, 5355.705436201047, 5357.35711714589, 5443.537299329522, 7846.136924938252, 7962.800929976797, 8633.309335253165, 8818.559072046372, 8915.910840891638, 8609.526476043879, 8631.48211107323, 8710.956445217733, 8721.738347849574, 8767.0, 6563.245226798979, 6606.966965165239, 6645.235797883209, 6718.0, 6728.091707619409, 6947.610477904541, 6967.7212911485, 7051.717931282691, 7081.575105493687, 7092.042574252616, 7538.660760265691, 7695.576743279174, 7771.145174030739, 7831.569263690324, 7833.5691536966015, 7810.10183828867, 8025.036995560336, 8038.799030024063, 8061.314788243065, 8088.757337279891, 6509.730602532461, 6525.412712855866, 6550.6069635822005, 6590.7693230736695, 6608.735650574115, 6789.15135608049, 6948.756793512202, 6965.199002114821, 7039.612821294878, 7077.469189810888, 6521.380468855451, 6599.373059559334, 6626.768063117768, 6649.0, 6654.201495820533, 6372.6495042773095, 6409.679516024087, 6419.871602568016, 6593.505487088391, 6598.736050557924, 6590.736370545124, 6609.735610575523, 6619.040239165198, 6655.068290439245, 6691.799246022627, 5964.701764911824, 5982.1325907744, 6015.428534289235, 6088.269407671108, 6103.145559621746, 5761.452661997104, 5926.111083337534, 5931.08068249422, 5973.820785376446, 5979.103134529855], "ext.html": [509.317514530529, 512.2751306900735, 523.871651445396, 531.0123170902123, 543.5895898596564, 28353.716462835364, 29625.0, 36801.079973000655, 37201.62798372016, 38199.80900095503, 40291.39562906551, 40452.39321410181, 40886.38670419939, 40888.79555602218, 40937.385939210864, 7629.8474030519355, 8591.012033616136, 8746.300295976307, 8746.737597872043, 8785.033646298902, 7411.48119631626, 9835.508224588777, 10214.13179879711, 10237.334573252714, 10278.177745780356, 10129.3922364658, 10292.536835842406, 10331.63839265626, 10338.948305258464, 10359.79280414395, 7796.415268854858, 8014.599270036475, 10268.127209187229, 10291.742706432324, 10354.741131471697, 9903.158231550255, 10154.08613224806, 10154.187664986783, 10165.237607179492, 10183.28716989811, 36762.63237367619, 37435.625643743486, 37785.0, 37914.8104259477, 37928.43107353392, 2573.266619013591, 2686.637303963979, 2869.2826793301674, 2907.0261462410117, 3151.3854798314337, 25939.48121037569, 26046.479070418674, 26245.73754262452, 26616.73383266162, 26737.465250694877, 2241.2267767620147, 2248.9437764055865, 2262.7850354216325, 2282.189822612965, 2353.8113252807393, 247098.0, 250206.0, 252756.0, 253212.0, 254714.0, 53524.99999999922, 54581.1812822808, 58114.0, 58544.0, 58621.70689146612, 60980.69509652512, 61059.38940610626, 61430.38569614247, 61859.0, 61862.69068654628, 13552.864471355357, 13675.179489230679, 13681.742512485329, 13821.447142114404, 13849.515266965607, 9978.351407158656, 10114.393136411838, 10137.239707022003, 10269.383836969657, 10275.229357798195, 18769.0, 18886.3389781357, 19123.330683426015, 19137.712934305997, 19215.51961200981, 7369.520981136209, 7630.8092297693, 7678.308952194329, 7735.994320738268, 7737.1102323233545, 854.7777577829809, 910.2444970674325, 992.5831150916632, 1000.0449570660147, 1048.3185929146116, 26505.867470662524, 26717.198484045508, 26753.464930701666, 26893.731062689123, 26983.730162698514, 960.1742501448888, 966.1160038564634, 1009.2178561614808, 1055.8416237564272, 1059.0045357364054, 12833.165844220095, 12876.549320773727, 13113.606591802261, 13125.474981000652, 13172.736545269041, 221165.0, 225900.0, 225957.0, 226260.0, 227320.0, 51084.48915510797, 51649.0, 51853.48146518562, 51952.22071668928, 52045.0, 1268.1123213750411, 1270.4410059573943, 1280.705437749323, 1284.8137020132215, 1288.935553222335, 24970.0, 25509.3622659435, 25657.230283091536, 25794.355141120872, 25810.0, 40165.39751903782, 40247.79876100601, 40331.395029075175, 40378.0, 40465.59534404736, 265739.0, 269127.0, 269586.0, 270229.0, 270390.0, 25662.743372566034, 25769.226923192335, 25944.846741394555, 26064.609030864172, 28813.423731525672, 30580.847095765268, 32881.0, 33493.83253083719, 35309.29381412306, 39977.40033899552, 31938.520922185722, 32322.0, 33198.0, 33301.50047749334, 33524.329513410084, 32512.51231231581, 32559.0, 33030.834845825615, 33078.669213307556, 33175.83412082924, 28799.424011519233, 29315.12054638364, 29375.0, 34137.146571334924, 34699.82650086733, 25701.485970280115, 26712.599311009963, 28337.43325133527, 29110.854445727637, 29682.406351873273, 20924.47688807792, 21274.255401060887, 21455.570888581828, 22037.889810550845, 22268.220612278492], "prototype.html": [279.82790583790967, 288.62478777589126, 292.8140630699505, 298.31834258718834, 300.60020173169687, 5696.857578560533, 5809.912851307228, 5836.6206196597195, 5900.203472531212, 5901.262342207224, 5718.256626638531, 5730.512906402951, 5746.655200687951, 5752.827415177541, 5781.075027995522, 4439.533848945863, 4445.955540444603, 4446.421965144526, 4449.5105538390835, 4469.0, 4427.867163985069, 4431.911361772763, 4446.110777844444, 4447.35513350564, 4454.799534020977, 4259.7231179973205, 4398.912021759563, 4409.691321607489, 4417.889552761175, 4457.754823484707, 4366.497852746943, 4380.036391993756, 4390.078083602447, 4391.2534869072015, 4413.360062790877, 3766.3785475396526, 3802.8098595070414, 3814.408766641175, 3818.389057750774, 3832.1952389997855, 5556.583256255797, 5565.0, 5654.830355089354, 5656.43435656431, 5670.064439367499, 4828.275758636198, 4925.704457732511, 4959.975200123977, 4998.5751211146735, 5002.199648056294, 5972.731227094748, 6032.517398608101, 6038.245219347582, 6041.758329666808, 6048.697565121726, 4107.219628270619, 4149.33610622302, 4153.501579810442, 4159.521655009682, 4162.646175075122, 6056.5457590680435, 6266.968665156691, 6329.303776584572, 6370.77702280418, 6390.7763228286785, 4145.108801607669, 4244.957550424518, 4250.723702959298, 4259.488861336659, 4262.168877068942, 4260.829566817292, 4290.764007979528, 4295.355696645528, 4306.547812479707, 4327.415798867176, 4780.139574876555, 4855.223164293696, 4889.926651100165, 4909.7790599423115, 4995.850124496271, 6070.666113363719, 6084.296397008845, 6098.024316109401, 6108.0, 6123.357047510036, 1510.3052595805832, 1515.9242037898061, 1530.8469153084825, 1534.6547026918854, 1535.5163123616026, 989.9257555683353, 1001.4291853643499, 1005.9295849290626, 1019.2202964731986, 1022.9130523905402, 5713.0, 5859.20900678403, 5914.467697907123, 5914.467697907209, 5916.349201587822, 6297.023961286008, 6334.3032266450655, 6355.332690067568, 6355.936440635627, 6367.299597044322, 5898.970505147447, 5901.822945311647, 5905.173275741399, 5908.0, 5910.1725758392995, 3244.545763593099, 3390.6439823818637, 3447.0865220716532, 3456.5333679953387, 3459.187091033605, 6540.0, 6552.3775241352, 6556.541042127101, 6563.671816409256, 6604.306547812506, 6486.67566621667, 6492.577982431127, 6499.610023398611, 6514.446272066927, 6543.770968016097, 6338.239411270585, 6532.864225171944, 6554.934450655528, 6568.671566421755, 6639.4024537790865, 6365.204349456318, 6375.971413578513, 6377.2984971654005, 6412.198475190601, 6413.551051426355, 6200.627962322275, 6207.037909124093, 6217.813465596039, 6257.030160325156, 6265.122882796321, 6326.525510586816, 6502.902456463063, 6566.310537393505, 6586.275509693834, 6596.175478065242, 4291.699581029298, 4307.870763877088, 4317.481902171759, 4338.6312163466455, 4355.0854320593035, 6175.84560385976, 6250.812475625738, 6269.435750782452, 6302.054691796267, 6305.211848518935, 6008.429199226067, 6184.5980011299125, 6213.539818142824, 6230.158928544589, 6258.186435763321, 6160.537959652955, 6167.167432396748, 6168.1056246844855, 6172.69136543162, 6234.376562343729, 5811.418858114154, 5982.282126144716, 6057.242844644419, 6075.848103797441, 6081.452669259788, 6114.785982490592, 6130.693465326626, 6184.041473571604, 6202.2867370253, 6276.654783986742, 6039.516838652985, 6045.21412216409, 6049.455549000435, 6086.02623580225, 6091.390860913873], "yui.html": [597.3578403216541, 605.4127496328562, 607.2474088139884, 615.3016326469456, 709.6629101176945, 10106.292559520836, 10362.378257304548, 12885.806712899303, 13034.21794692318, 13053.282069486186, 9742.0, 12754.298513581749, 13087.672808179777, 13094.279814610192, 13158.407871645775, 637.5568979559208, 811.1158836867828, 829.6598394658191, 832.3382910586068, 843.4939036578065, 647.7020570537559, 794.8012996750813, 843.3464065349342, 847.3560094328293, 852.1265702654797, 853.15111464093, 869.4956924983526, 869.5087275689216, 870.5908223135116, 871.1419252036738, 854.7521218846528, 857.0615176381851, 857.3012994409536, 858.9570521473963, 865.1435079271475, 640.1517988665038, 640.3596403596404, 643.5655932245716, 643.9581427207216, 645.2386184302521, 12419.006479481619, 12586.748265034648, 12587.370631468482, 12657.30384828834, 12731.172473789175, 10578.047975682148, 10621.628243011535, 10846.132309415307, 10854.45727713611, 11019.338839669645, 8610.225079742853, 8779.20987111163, 8826.955865220632, 8873.866891996626, 9306.86039709405, 3022.425739109562, 3118.3607360491046, 3168.8098714077228, 3172.0, 3276.737860971117, 43975.78012109919, 44102.779486102365, 44228.0, 44313.77843110796, 46035.30947035797, 8217.83564328722, 8349.916500834914, 8458.915410845935, 8557.743267701979, 8846.646134154562, 17475.650486990187, 17477.300907963792, 17516.737248941277, 17601.823981760273, 17699.20353584092, 5734.283214598176, 5812.767489300465, 6028.125921741323, 6029.517638588903, 6060.151578778975, 3382.2051817822794, 3383.864645414156, 3396.354692608446, 3419.145213696576, 3444.638312977101, 2489.738577449342, 2514.371407148213, 2515.0442831723826, 2515.7735803777746, 2518.257114151293, 422.72945314998424, 425.3109961861804, 436.0080816143299, 442.3541629221373, 443.7803287372771, 460.900906305146, 473.1884817537939, 491.9311296418504, 499.48552990419927, 589.4694774702716, 7271.381932535794, 7708.306252437307, 7714.1128770192145, 7773.222677732295, 7825.960870195727, 477.73485715428274, 543.9972800135974, 551.0466892276385, 551.6993238684927, 611.5688439650125, 3522.348365552381, 3645.799481028569, 3682.3739964206147, 3689.1330537323706, 3727.254549090193, 54474.0, 54914.0, 55591.16613250804, 55785.721071394386, 55815.44184558102, 47059.294110588366, 47887.521124789004, 48046.27930581044, 48299.75850120727, 48365.032699345815, 41908.161836763094, 41992.580074199475, 42123.0, 42123.368149477785, 42151.156976860904, 7489.588072656056, 7674.769756907302, 7781.144074151952, 7844.686212551434, 8134.552599607078, 31946.36107277888, 32006.51990220102, 32207.0, 32633.836830816643, 32692.50961235631, 40617.0, 43215.56784432115, 43478.347824782024, 43770.56229437665, 44292.33561496516, 6903.654817259217, 6995.720171193096, 7048.118985126859, 7166.912438723156, 7280.344768970818, 10069.949650251701, 10209.795804084026, 10343.0, 10502.842457363298, 10952.34285942846, 9743.415395076318, 9750.902490974999, 9761.0, 10046.095851373411, 10314.329568578018, 9387.342885997914, 9859.112679858847, 9985.750356241153, 10020.048095430922, 10337.483125843828, 9647.372920760128, 9717.076877696607, 9873.506324683593, 10000.799984000425, 10171.7457063574, 8016.0, 8169.5098294102545, 8553.82892342162, 8581.098984606777, 8865.0, 7998.200179982188, 8165.77513372975, 8337.666493340199, 8714.172153645393, 8929.464232146092]}, "summary": {"lowerIsBetter": false, "suite": 6215.493716029871, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6800.834569726404, "unit": "ms", "value": 6800.834569726404}, "dojo.html": {"lowerIsBetter": false, "filtered": 4868.122623907008, "unit": "ms", "value": 4868.122623907008}, "mootools.html": {"lowerIsBetter": false, "filtered": 4022.4427435998145, "unit": "ms", "value": 4022.4427435998145}, "ext.html": {"lowerIsBetter": false, "filtered": 16927.77825529006, "unit": "ms", "value": 16927.77825529006}, "prototype.html": {"lowerIsBetter": false, "filtered": 4585.996351822334, "unit": "ms", "value": 4585.996351822334}, "yui.html": {"lowerIsBetter": false, "filtered": 5576.561663536155, "unit": "ms", "value": 5576.561663536155}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0029"}, "testrun": {"date": 1447518036, "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": "20151114072932", "branch": "Fx-Team", "revision": "3d8143254eac173858c97f6e0d3ae9a48be3dcbc"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 160.0, 170.0, 172.0, 174.0, 175.0, 175.0, 175.0, 173.0, 172.0], "ai-astar": [109.0, 111.0, 105.0, 109.0, 109.0, 109.0, 108.0, 111.0, 100.0, 110.0], "imaging-gaussian-blur": [123.0, 125.0, 128.0, 134.0, 129.0, 129.0, 123.0, 123.0, 130.0, 136.0], "audio-beat-detection": [156.0, 136.0, 158.0, 167.0, 125.0, 156.0, 159.0, 138.0, 183.0, 142.0], "json-stringify-tinderbox": [67.0, 66.0, 70.0, 70.0, 70.0, 77.0, 73.0, 74.0, 73.0, 73.0], "stanford-crypto-pbkdf2": [156.0, 160.0, 155.0, 154.0, 171.0, 167.0, 155.0, 171.0, 174.0, 160.0], "json-parse-financial": [59.0, 58.0, 59.0, 60.0, 61.0, 63.0, 63.0, 73.0, 62.0, 66.0], "stanford-crypto-sha256-iterative": [70.0, 72.0, 73.0, 73.0, 73.0, 76.0, 77.0, 79.0, 76.0, 77.0], "audio-fft": [77.0, 80.0, 93.0, 89.0, 73.0, 75.0, 78.0, 94.0, 93.0, 72.0], "imaging-darkroom": [129.0, 131.0, 136.0, 141.0, 138.0, 135.0, 136.0, 136.0, 137.0, 141.0], "stanford-crypto-ccm": [131.0, 140.0, 149.0, 137.0, 149.0, 141.0, 138.0, 137.0, 147.0, 142.0], "audio-oscillator": [102.0, 99.0, 138.0, 93.0, 95.0, 95.0, 139.0, 96.0, 95.0, 142.0], "stanford-crypto-aes": [94.0, 88.0, 94.0, 92.0, 96.0, 95.0, 96.0, 92.0, 94.0, 93.0], "imaging-desaturate": [101.0, 110.0, 104.0, 104.0, 113.0, 109.0, 108.0, 105.0, 113.0, 113.0]}, "summary": {"lowerIsBetter": true, "suite": 1599.8, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 82.4, "unit": "ms", "value": 82.4}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 162.3, "unit": "ms", "value": 162.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 152.0, "unit": "ms", "value": 152.0}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 141.1, "unit": "ms", "value": 141.1}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 136.0, "unit": "ms", "value": 136.0}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 62.4, "unit": "ms", "value": 62.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 109.4, "unit": "ms", "value": 109.4}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.1, "unit": "ms", "value": 108.1}, "audio-dft": {"lowerIsBetter": true, "filtered": 170.8, "unit": "ms", "value": 170.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 74.6, "unit": "ms", "value": 74.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 71.3, "unit": "ms", "value": 71.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 128.0, "unit": "ms", "value": 128.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 93.4, "unit": "ms", "value": 93.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 108.0, "unit": "ms", "value": 108.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0029"}, "testrun": {"date": 1447518036, "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": "20151114072932", "branch": "Fx-Team", "revision": "3d8143254eac173858c97f6e0d3ae9a48be3dcbc"}}, {"talos_counters": {}, "results": {"DeltaBlue": [203.00446609825417], "Encrypt": [348.6750348675035], "NavierStokes": [6115.8536585365855], "Decrypt": [6134.9693251533745], "Splay": [643.915003219575], "Richards": [174.06440382941688], "RegExp": [31500.0], "Earley": [1032.6732673267327], "Boyer": [13986.111111111111], "RayTrace": [2047.034764826176]}, "summary": {"lowerIsBetter": false, "suite": 17195.242224397887, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 325.697268, "unit": "score", "value": 325.697268}, "Encrypt": {"lowerIsBetter": false, "filtered": 763.407108, "unit": "score", "value": 763.407108}, "NavierStokes": {"lowerIsBetter": false, "filtered": 242.64805583250268, "unit": "score", "value": 242.64805583250268}, "Decrypt": {"lowerIsBetter": false, "filtered": 43.387503000000024, "unit": "score", "value": 43.387503000000024}, "Splay": {"lowerIsBetter": false, "filtered": 126.55552300000004, "unit": "score", "value": 126.55552300000004}, "RegExp": {"lowerIsBetter": false, "filtered": 28.920158730158732, "unit": "score", "value": 28.920158730158732}, "Richards": {"lowerIsBetter": false, "filtered": 202.80999, "unit": "score", "value": 202.80999}, "Earley": {"lowerIsBetter": false, "filtered": 645.3764429530202, "unit": "score", "value": 645.3764429530202}, "Boyer": {"lowerIsBetter": false, "filtered": 47.65177358490565, "unit": "score", "value": 47.65177358490565}, "RayTrace": {"lowerIsBetter": false, "filtered": 361.49312787212784, "unit": "score", "value": 361.49312787212784}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2", "os": "mac", "name": "t-yosemite-r5-0029"}, "testrun": {"date": 1447518036, "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": "20151114072932", "branch": "Fx-Team", "revision": "3d8143254eac173858c97f6e0d3ae9a48be3dcbc"}}] 08:40:49 INFO - RETURN: dromaeo_css: 6215.49 08:40:49 INFO - RETURN: kraken: 1599.80 08:40:49 INFO - RETURN: v8_7: 17195.24 08:40:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,55]]", "result": "17195.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,55]]", "result": "1599.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,55]]", "result": "6215.49"}}} 08:40:49 INFO - Return code: 0 08:40:49 INFO - # TBPL SUCCESS # 08:40:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:40:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:40:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:40:49 INFO - 2015-11-14 08:40:49.687 screenresolution[1655:10085] starting screenresolution argv=screenresolution get 08:40:49 INFO - 2015-11-14 08:40:49.690 screenresolution[1655:10085] Display 0: 1600x1200x32@60 08:40:49 INFO - 2015-11-14 08:40:49.696 screenresolution[1656:10089] starting screenresolution argv=screenresolution list 08:40:49 INFO - Available Modes on Display 0 08:40:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:40:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:40:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:40:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:40:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:40:49 INFO - Intel HD Graphics 3000: 08:40:49 INFO - Chipset Model: Intel HD Graphics 3000 08:40:49 INFO - Type: GPU 08:40:49 INFO - Bus: Built-In 08:40:49 INFO - VRAM (Total): 512 MB 08:40:49 INFO - VRAM (Dynamic, Max): 10 08:40:49 INFO - Vendor: Intel (0x8086) 08:40:49 INFO - Device ID: 0x0116 08:40:49 INFO - Revision ID: 0x0009 08:40:49 INFO - Displays: 08:40:49 INFO - Display: 08:40:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:40:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:40:49 INFO - Display Serial Number: 1600x1200 60 08:40:49 INFO - Main Display: Yes 08:40:49 INFO - Mirror: Off 08:40:49 INFO - Online: Yes 08:40:49 INFO - Rotation: Supported 08:40:49 INFO - Return code: 0 08:40:49 INFO - Running post-action listener: _resource_record_post_action 08:40:49 INFO - Running post-run listener: _resource_record_post_run 08:40:51 INFO - Total resource usage - Wall time: 1253s; CPU: 30.0%; Read bytes: 40846336; Write bytes: 686032896; Read time: 6011; Write time: 38882 08:40:51 INFO - install - Wall time: 39s; CPU: 30.0%; Read bytes: 337371648; Write bytes: 335280128; Read time: 33745; Write time: 4556 08:40:51 INFO - run-tests - Wall time: 1214s; CPU: 30.0%; Read bytes: 39924736; Write bytes: 340393984; Read time: 5687; Write time: 32753 08:40:51 INFO - Running post-run listener: _upload_blobber_files 08:40:51 INFO - Blob upload gear active. 08:40:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:40:51 INFO - Copying logs to upload dir... 08:40:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1332.136463 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 12 secs) (at 2015-11-14 08:40:51.101417) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-14 08:40:51.104705) ========= 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.ISU0glyeF9/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.su9tswsi2h/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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/lU2yAzo6TMq2GkQu593RIQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010013 build_url: 'https://queue.taskcluster.net/v1/task/lU2yAzo6TMq2GkQu593RIQ/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-14 08:40:51.130981) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:40:51.131361) ========= 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.ISU0glyeF9/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.su9tswsi2h/Listeners TMPDIR=/var/folders/qw/q64zc0j15_j7091vn12r5y6800000w/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.005107 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-14 08:40:51.181631) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 08:40:51.181988) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-14 08:40:51.182411) ========= ========= Total master_lag: 2.53 =========