builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0027 starttime: 1448386185.02 results: success (0) buildid: 20151124083121 builduid: 57ec50228a394e12a2ddb244727a7fda revision: d516d82f29a2636c5834c7f3c932025b8e85a8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.018240) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.018675) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.018954) ========= 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.LaKIJGmQZh/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.djHPg5n9pt/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005167 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.040459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.040751) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.056347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.056894) ========= 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.LaKIJGmQZh/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.djHPg5n9pt/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005719 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.106191) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.106524) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.106883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.107161) ========= 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.LaKIJGmQZh/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.djHPg5n9pt/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-24 09:29:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 7.03M=0.002s 2015-11-24 09:29:45 (7.03 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124082 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.244471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.244777) ========= 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.LaKIJGmQZh/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.djHPg5n9pt/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.035558 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.293287) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:45.293651) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d516d82f29a2636c5834c7f3c932025b8e85a8ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d516d82f29a2636c5834c7f3c932025b8e85a8ad --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LaKIJGmQZh/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.djHPg5n9pt/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-24 09:29:45,368 truncating revision to first 12 chars 2015-11-24 09:29:45,368 Setting DEBUG logging. 2015-11-24 09:29:45,368 attempt 1/10 2015-11-24 09:29:45,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d516d82f29a2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-24 09:29:45,749 unpacking tar archive at: fx-team-d516d82f29a2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619977 ========= master_lag: 0.19 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:46.104678) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:46.104990) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:46.116202) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:46.116573) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-24 09:29:46.117016) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-24 09:29:46.117314) ========= /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.LaKIJGmQZh/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.djHPg5n9pt/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:29:46 INFO - MultiFileLogger online at 20151124 09:29:46 in /builds/slave/test 09:29:46 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 09:29:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:29:46 INFO - {'append_to_log': False, 09:29:46 INFO - 'base_work_dir': '/builds/slave/test', 09:29:46 INFO - 'blob_upload_branch': 'Fx-Team', 09:29:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:29:46 INFO - 'branch': 'Fx-Team', 09:29:46 INFO - 'buildbot_json_path': 'buildprops.json', 09:29:46 INFO - 'config_files': ('talos/mac_config.py',), 09:29:46 INFO - 'default_actions': ('clobber', 09:29:46 INFO - 'read-buildbot-config', 09:29:46 INFO - 'download-and-extract', 09:29:46 INFO - 'populate-webroot', 09:29:46 INFO - 'create-virtualenv', 09:29:46 INFO - 'install', 09:29:46 INFO - 'run-tests'), 09:29:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:29:46 INFO - 'download_minidump_stackwalk': True, 09:29:46 INFO - 'download_symbols': 'ondemand', 09:29:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:29:46 INFO - 'tooltool.py': '/tools/tooltool.py', 09:29:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:29:46 INFO - '/tools/misc-python/virtualenv.py')}, 09:29:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:29:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:29:46 INFO - 'installer_path': 'installer.exe', 09:29:46 INFO - 'log_level': 'info', 09:29:46 INFO - 'log_name': 'talos', 09:29:46 INFO - 'log_to_console': True, 09:29:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:29:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:29:46 INFO - 'opt_config_files': (), 09:29:46 INFO - 'pip_index': False, 09:29:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:29:46 INFO - 'cmd': ('bash', 09:29:46 INFO - '-c', 09:29:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:29:46 INFO - 'enabled': True, 09:29:46 INFO - 'halt_on_failure': False, 09:29:46 INFO - 'name': 'check_screen_resolution'},), 09:29:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:29:46 INFO - 'cmd': ('bash', 09:29:46 INFO - '-c', 09:29:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:29:46 INFO - 'enabled': True, 09:29:46 INFO - 'halt_on_failure': False, 09:29:46 INFO - 'name': 'check_screen_resolution'},), 09:29:46 INFO - 'run_cmd_checks_enabled': True, 09:29:46 INFO - 'sps_profile': False, 09:29:46 INFO - 'sps_profile_interval': 0, 09:29:46 INFO - 'suite': 'dromaeojs', 09:29:46 INFO - 'system_bits': '64', 09:29:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:29:46 INFO - 'title': 't-yosemite-r7-0027', 09:29:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:29:46 INFO - 'use_talos_json': True, 09:29:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:29:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:29:46 INFO - 'work_dir': 'build'} 09:29:46 INFO - ##### 09:29:46 INFO - ##### Running clobber step. 09:29:46 INFO - ##### 09:29:46 INFO - Running pre-action listener: _resource_record_pre_action 09:29:46 INFO - Running main action method: clobber 09:29:46 INFO - rmtree: /builds/slave/test/build 09:29:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:29:47 INFO - Running post-action listener: _resource_record_post_action 09:29:47 INFO - ##### 09:29:47 INFO - ##### Running read-buildbot-config step. 09:29:47 INFO - ##### 09:29:47 INFO - Running pre-action listener: _resource_record_pre_action 09:29:47 INFO - Running main action method: read_buildbot_config 09:29:47 INFO - Using buildbot properties: 09:29:47 INFO - { 09:29:47 INFO - "properties": { 09:29:47 INFO - "buildnumber": 19, 09:29:47 INFO - "product": "firefox", 09:29:47 INFO - "script_repo_revision": "production", 09:29:47 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:29:47 INFO - "repository": "", 09:29:47 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:29:47 INFO - "buildid": "20151124083121", 09:29:47 INFO - "slavename": "t-yosemite-r7-0027", 09:29:47 INFO - "pgo_build": "False", 09:29:47 INFO - "basedir": "/builds/slave/test", 09:29:47 INFO - "project": "", 09:29:47 INFO - "platform": "yosemite_r7", 09:29:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:29:47 INFO - "slavebuilddir": "test", 09:29:47 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:29:47 INFO - "branch": "fx-team", 09:29:47 INFO - "repo_path": "integration/fx-team", 09:29:47 INFO - "stage_platform": "macosx64", 09:29:47 INFO - "builduid": "57ec50228a394e12a2ddb244727a7fda", 09:29:47 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:29:47 INFO - }, 09:29:47 INFO - "sourcestamp": { 09:29:47 INFO - "repository": "", 09:29:47 INFO - "hasPatch": false, 09:29:47 INFO - "project": "", 09:29:47 INFO - "branch": "fx-team-macosx64-talos", 09:29:47 INFO - "changes": [ 09:29:47 INFO - { 09:29:47 INFO - "category": null, 09:29:47 INFO - "files": [ 09:29:47 INFO - { 09:29:47 INFO - "url": null, 09:29:47 INFO - "name": "https://queue.taskcluster.net/v1/task/WOU2LHsUQre1bajTv8khbA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 09:29:47 INFO - } 09:29:47 INFO - ], 09:29:47 INFO - "repository": "", 09:29:47 INFO - "rev": "0403cb97fb51eb7a05ae2f8091fe031d79ae6ae1", 09:29:47 INFO - "who": "jwein@mozilla.com", 09:29:47 INFO - "when": 1448384879, 09:29:47 INFO - "number": 6700820, 09:29:47 INFO - "comments": "Bug 1100662 - Fix browser_notification_tab_switching.js to work in e10s mode. r=MattN", 09:29:47 INFO - "project": "", 09:29:47 INFO - "at": "Tue 24 Nov 2015 09:07:59", 09:29:47 INFO - "branch": "fx-team-macosx64-talos", 09:29:47 INFO - "revlink": "", 09:29:47 INFO - "properties": [ 09:29:47 INFO - [ 09:29:47 INFO - "buildid", 09:29:47 INFO - "20151124082333", 09:29:47 INFO - "Change" 09:29:47 INFO - ], 09:29:47 INFO - [ 09:29:47 INFO - "builduid", 09:29:47 INFO - "d00a46168ce74b29b284fd63de339268", 09:29:47 INFO - "Change" 09:29:47 INFO - ], 09:29:47 INFO - [ 09:29:47 INFO - "pgo_build", 09:29:47 INFO - "False", 09:29:47 INFO - "Change" 09:29:47 INFO - ] 09:29:47 INFO - ], 09:29:47 INFO - "revision": "0403cb97fb51eb7a05ae2f8091fe031d79ae6ae1" 09:29:47 INFO - }, 09:29:47 INFO - { 09:29:47 INFO - "category": null, 09:29:47 INFO - "files": [ 09:29:47 INFO - { 09:29:47 INFO - "url": null, 09:29:47 INFO - "name": "https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 09:29:47 INFO - } 09:29:47 INFO - ], 09:29:47 INFO - "repository": "", 09:29:47 INFO - "rev": "d516d82f29a2636c5834c7f3c932025b8e85a8ad", 09:29:47 INFO - "who": "jwein@mozilla.com", 09:29:47 INFO - "when": 1448385641, 09:29:47 INFO - "number": 6700853, 09:29:47 INFO - "comments": "Bug 1213421 - Add a test that verifies the text of a notification is present. r=MattN", 09:29:47 INFO - "project": "", 09:29:47 INFO - "at": "Tue 24 Nov 2015 09:20:41", 09:29:47 INFO - "branch": "fx-team-macosx64-talos", 09:29:47 INFO - "revlink": "", 09:29:47 INFO - "properties": [ 09:29:47 INFO - [ 09:29:47 INFO - "buildid", 09:29:47 INFO - "20151124083121", 09:29:47 INFO - "Change" 09:29:47 INFO - ], 09:29:47 INFO - [ 09:29:47 INFO - "builduid", 09:29:47 INFO - "57ec50228a394e12a2ddb244727a7fda", 09:29:47 INFO - "Change" 09:29:47 INFO - ], 09:29:47 INFO - [ 09:29:47 INFO - "pgo_build", 09:29:47 INFO - "False", 09:29:47 INFO - "Change" 09:29:47 INFO - ] 09:29:47 INFO - ], 09:29:47 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:29:47 INFO - } 09:29:47 INFO - ], 09:29:47 INFO - "revision": "d516d82f29a2636c5834c7f3c932025b8e85a8ad" 09:29:47 INFO - } 09:29:47 INFO - } 09:29:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 09:29:47 INFO - Running post-action listener: _resource_record_post_action 09:29:47 INFO - ##### 09:29:47 INFO - ##### Running download-and-extract step. 09:29:47 INFO - ##### 09:29:47 INFO - Running pre-action listener: _resource_record_pre_action 09:29:47 INFO - Running main action method: download_and_extract 09:29:47 INFO - mkdir: /builds/slave/test/build/tests 09:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:47 INFO - https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:29:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/test_packages.json 09:29:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/test_packages.json 09:29:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:29:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:29:49 INFO - Downloaded 1149 bytes. 09:29:49 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:29:49 INFO - Using the following test package requirements: 09:29:49 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:29:49 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:29:49 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 09:29:49 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:29:49 INFO - u'jsshell-mac.zip'], 09:29:49 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:29:49 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 09:29:49 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:29:49 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:29:49 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 09:29:49 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:29:49 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 09:29:49 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:29:49 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 09:29:49 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 09:29:49 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 09:29:49 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 09:29:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:49 INFO - https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:29:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:29:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:29:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:29:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:29:50 INFO - Downloaded 17526956 bytes. 09:29:50 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 09:29:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:29:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:29:53 INFO - Return code: 0 09:29:53 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 09:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:53 INFO - https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:29:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:29:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:29:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:29:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:29:54 INFO - Downloaded 17526956 bytes. 09:29:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 09:29:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 09:29:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 09:29:57 INFO - Return code: 0 09:29: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')]} 09:29:57 INFO - https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:29:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:29:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:29:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:29:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:29:59 INFO - Downloaded 11130997 bytes. 09:29:59 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 09:29:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 09:29:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 09:29:59 INFO - Return code: 0 09:29:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:59 INFO - https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:29:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:29:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:29:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 09:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 09:30:03 INFO - Downloaded 109909020 bytes. 09:30:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:30:03 INFO - mkdir: /builds/slave/test/properties 09:30:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:30:03 INFO - Writing to file /builds/slave/test/properties/build_url 09:30:03 INFO - Contents: 09:30:03 INFO - build_url:https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 09:30:03 INFO - Running post-action listener: _resource_record_post_action 09:30:03 INFO - Running post-action listener: set_extra_try_arguments 09:30:03 INFO - ##### 09:30:03 INFO - ##### Running populate-webroot step. 09:30:03 INFO - ##### 09:30:03 INFO - Running pre-action listener: _resource_record_pre_action 09:30:03 INFO - Running main action method: populate_webroot 09:30:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:30:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:30:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:30:03 INFO - '../fennec_ids.txt'], 09:30:03 INFO - 'tests': ['tcheck2']}, 09:30:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:30:03 INFO - '--tppagecycles', 09:30:03 INFO - '7'], 09:30:03 INFO - 'tests': ['tsvgm']}}, 09:30:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:30:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:30:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:30:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:30:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:30:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:30:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:03 INFO - 'talos_options': ['--e10s'], 09:30:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:03 INFO - 'tests': ['damp', 'tps']}, 09:30:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:03 INFO - 'talos_options': ['--e10s'], 09:30:03 INFO - 'tests': ['damp', 'tps']}, 09:30:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:30:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:30:03 INFO - 'other': {'tests': ['a11yr', 09:30:03 INFO - 'ts_paint', 09:30:03 INFO - 'tpaint', 09:30:03 INFO - 'sessionrestore', 09:30:03 INFO - 'sessionrestore_no_auto_restore']}, 09:30:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:30:03 INFO - 'tests': ['a11yr', 09:30:03 INFO - 'ts_paint', 09:30:03 INFO - 'tpaint', 09:30:03 INFO - 'sessionrestore', 09:30:03 INFO - 'sessionrestore_no_auto_restore']}, 09:30:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:30:03 INFO - 'tests': ['a11yr', 09:30:03 INFO - 'ts_paint', 09:30:03 INFO - 'tpaint', 09:30:03 INFO - 'sessionrestore', 09:30:03 INFO - 'sessionrestore_no_auto_restore']}, 09:30:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:30:03 INFO - 'tests': ['a11yr', 09:30:03 INFO - 'ts_paint', 09:30:03 INFO - 'tpaint', 09:30:03 INFO - 'sessionrestore', 09:30:03 INFO - 'sessionrestore_no_auto_restore']}, 09:30:03 INFO - 'other_l64': {'tests': ['a11yr', 09:30:03 INFO - 'ts_paint', 09:30:03 INFO - 'tpaint', 09:30:03 INFO - 'sessionrestore', 09:30:03 INFO - 'sessionrestore_no_auto_restore']}, 09:30:03 INFO - 'other_nol64': {'tests': ['a11yr', 09:30:03 INFO - 'ts_paint', 09:30:03 INFO - 'tpaint', 09:30:03 INFO - 'sessionrestore', 09:30:03 INFO - 'sessionrestore_no_auto_restore']}, 09:30:03 INFO - 'svgr': {'tests': ['tsvgx', 09:30:03 INFO - 'tsvgr_opacity', 09:30:03 INFO - 'tart', 09:30:03 INFO - 'tscrollx', 09:30:03 INFO - 'cart']}, 09:30:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:30:03 INFO - 'tests': ['tsvgx', 09:30:03 INFO - 'tsvgr_opacity', 09:30:03 INFO - 'tart', 09:30:03 INFO - 'tscrollx', 09:30:03 INFO - 'cart']}, 09:30:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:03 INFO - 'tests': ['tp5o']}, 09:30:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:03 INFO - 'talos_options': ['--e10s'], 09:30:03 INFO - 'tests': ['tp5o']}, 09:30:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:03 INFO - 'talos_options': ['--xperf_path', 09:30:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:03 INFO - 'tests': ['tp5n']}, 09:30:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:03 INFO - 'talos_options': ['--e10s', 09:30:03 INFO - '--xperf_path', 09:30:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:03 INFO - 'tests': ['tp5n']}}, 09:30:03 INFO - 'talos.zip': {'path': '', 09:30:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:30:03 INFO - Running post-action listener: _resource_record_post_action 09:30:03 INFO - ##### 09:30:03 INFO - ##### Running create-virtualenv step. 09:30:03 INFO - ##### 09:30:03 INFO - Running pre-action listener: _resource_record_pre_action 09:30:03 INFO - Running main action method: create_virtualenv 09:30:03 INFO - Creating virtualenv /builds/slave/test/build/venv 09:30:03 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 09:30:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:30:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:30:03 INFO - Using real prefix '/tools/python27' 09:30:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:30:04 INFO - Installing distribute.............................................................................................................................................................................................done. 09:30:07 INFO - Installing pip.................done. 09:30:07 INFO - Return code: 0 09:30:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:07 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 0x108991490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10896e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd510585610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b59f0>, '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 0x108614db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088a88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/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.djHPg5n9pt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:30:07 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 09:30:07 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 09:30:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/Render', 09:30:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:07 INFO - 'HOME': '/Users/cltbld', 09:30:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:07 INFO - 'LOGNAME': 'cltbld', 09:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:07 INFO - 'MOZ_NO_REMOTE': '1', 09:30:07 INFO - 'NO_EM_RESTART': '1', 09:30:07 INFO - 'PAGER': '/bin/cat', 09:30:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:07 INFO - 'PWD': '/builds/slave/test', 09:30:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:07 INFO - 'SHELL': '/bin/bash', 09:30:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djHPg5n9pt/Listeners', 09:30:07 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:30:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:07 INFO - 'USER': 'cltbld', 09:30:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:07 INFO - 'XPC_FLAGS': '0x0', 09:30:07 INFO - 'XPC_SERVICE_NAME': '0', 09:30:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:07 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 09:30:07 INFO - Cleaning up... 09:30:07 INFO - Return code: 0 09:30:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:07 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 0x108991490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10896e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd510585610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b59f0>, '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 0x108614db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088a88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/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.djHPg5n9pt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:30:07 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 09:30:07 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 09:30:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/Render', 09:30:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:07 INFO - 'HOME': '/Users/cltbld', 09:30:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:07 INFO - 'LOGNAME': 'cltbld', 09:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:07 INFO - 'MOZ_NO_REMOTE': '1', 09:30:07 INFO - 'NO_EM_RESTART': '1', 09:30:07 INFO - 'PAGER': '/bin/cat', 09:30:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:07 INFO - 'PWD': '/builds/slave/test', 09:30:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:07 INFO - 'SHELL': '/bin/bash', 09:30:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djHPg5n9pt/Listeners', 09:30:07 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:30:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:07 INFO - 'USER': 'cltbld', 09:30:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:07 INFO - 'XPC_FLAGS': '0x0', 09:30:07 INFO - 'XPC_SERVICE_NAME': '0', 09:30:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:08 INFO - Downloading/unpacking psutil>=0.7.1 09:30:08 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 09:30:08 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 09:30:08 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 09:30:08 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 09:30:08 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 09:30:08 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 09:30:10 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:30:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:10 INFO - Installing collected packages: psutil 09:30:10 INFO - Running setup.py install for psutil 09:30:10 INFO - building 'psutil._psutil_osx' extension 09:30:10 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 09:30:11 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 09:30:11 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 09:30:11 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 09:30:11 INFO - building 'psutil._psutil_posix' extension 09:30:11 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 09:30:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:30:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:30:11 INFO - ^ 09:30:11 INFO - 1 warning generated. 09:30:11 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 09:30:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:30:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:30:11 INFO - Successfully installed psutil 09:30:11 INFO - Cleaning up... 09:30:12 INFO - Return code: 0 09:30:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108991490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10896e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd510585610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b59f0>, '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 0x108614db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088a88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/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.djHPg5n9pt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:30:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/Render', 09:30:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:12 INFO - 'HOME': '/Users/cltbld', 09:30:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:12 INFO - 'LOGNAME': 'cltbld', 09:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:12 INFO - 'MOZ_NO_REMOTE': '1', 09:30:12 INFO - 'NO_EM_RESTART': '1', 09:30:12 INFO - 'PAGER': '/bin/cat', 09:30:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:12 INFO - 'PWD': '/builds/slave/test', 09:30:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:12 INFO - 'SHELL': '/bin/bash', 09:30:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djHPg5n9pt/Listeners', 09:30:12 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:30:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:12 INFO - 'USER': 'cltbld', 09:30:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:12 INFO - 'XPC_FLAGS': '0x0', 09:30:12 INFO - 'XPC_SERVICE_NAME': '0', 09:30:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:30:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:30:14 INFO - Installing collected packages: mozsystemmonitor 09:30:14 INFO - Running setup.py install for mozsystemmonitor 09:30:14 INFO - Successfully installed mozsystemmonitor 09:30:14 INFO - Cleaning up... 09:30:14 INFO - Return code: 0 09:30:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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')]} 09:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x108991490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10896e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd510585610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b59f0>, '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 0x108614db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088a88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/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.djHPg5n9pt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:30:14 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 09:30:14 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 09:30:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/Render', 09:30:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:14 INFO - 'HOME': '/Users/cltbld', 09:30:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:14 INFO - 'LOGNAME': 'cltbld', 09:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:14 INFO - 'MOZ_NO_REMOTE': '1', 09:30:14 INFO - 'NO_EM_RESTART': '1', 09:30:14 INFO - 'PAGER': '/bin/cat', 09:30:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:14 INFO - 'PWD': '/builds/slave/test', 09:30:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:14 INFO - 'SHELL': '/bin/bash', 09:30:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djHPg5n9pt/Listeners', 09:30:14 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:30:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:14 INFO - 'USER': 'cltbld', 09:30:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:14 INFO - 'XPC_FLAGS': '0x0', 09:30:14 INFO - 'XPC_SERVICE_NAME': '0', 09:30:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:30:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:30:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:30:17 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 09:30:17 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 09:30:17 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 09:30:17 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 09:30:17 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 09:30:17 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 09:30:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:30:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:30:17 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 09:30:17 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 09:30:17 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 09:30:17 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 09:30:17 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 09:30:17 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 09:30:18 INFO - Downloading docopt-0.6.1.tar.gz 09:30:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:30:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:30:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:30:18 INFO - Running setup.py install for blobuploader 09:30:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:30:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:30:18 INFO - Running setup.py install for requests 09:30:19 INFO - Running setup.py install for docopt 09:30:19 INFO - Successfully installed blobuploader requests docopt 09:30:19 INFO - Cleaning up... 09:30:19 INFO - Return code: 0 09:30:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:19 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 0x108991490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10896e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd510585610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b59f0>, '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 0x108614db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088a88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/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.djHPg5n9pt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:30:19 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 09:30:19 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 09:30:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/Render', 09:30:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:19 INFO - 'HOME': '/Users/cltbld', 09:30:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:19 INFO - 'LOGNAME': 'cltbld', 09:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:19 INFO - 'MOZ_NO_REMOTE': '1', 09:30:19 INFO - 'NO_EM_RESTART': '1', 09:30:19 INFO - 'PAGER': '/bin/cat', 09:30:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:19 INFO - 'PWD': '/builds/slave/test', 09:30:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:19 INFO - 'SHELL': '/bin/bash', 09:30:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djHPg5n9pt/Listeners', 09:30:19 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:30:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:19 INFO - 'USER': 'cltbld', 09:30:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:19 INFO - 'XPC_FLAGS': '0x0', 09:30:19 INFO - 'XPC_SERVICE_NAME': '0', 09:30:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:19 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-gUHnn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:19 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-lOYhOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:19 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Cdu7FW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:19 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-kFzxhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:19 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Fbbvuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-L0odNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Zg6prE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-buU64P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-wwvbHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-9f_I9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Hxt_4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-HtThen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-iCmihP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:20 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-LzKDoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-ksHVy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-ad2pLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:21 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-YTfpt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:30:21 INFO - Running setup.py install for manifestparser 09:30:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:30:21 INFO - Running setup.py install for mozcrash 09:30:21 INFO - Running setup.py install for mozdebug 09:30:21 INFO - Running setup.py install for mozdevice 09:30:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:30:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:30:21 INFO - Running setup.py install for mozfile 09:30:22 INFO - Running setup.py install for mozhttpd 09:30:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:30:22 INFO - Running setup.py install for mozinfo 09:30:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:30:22 INFO - Running setup.py install for mozInstall 09:30:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:30:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:30:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:30:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:30:22 INFO - Running setup.py install for mozleak 09:30:22 INFO - Running setup.py install for mozlog 09:30:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:30:22 INFO - Running setup.py install for moznetwork 09:30:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:30:22 INFO - Running setup.py install for mozprocess 09:30:23 INFO - Running setup.py install for mozprofile 09:30:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:30:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:30:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:30:23 INFO - Running setup.py install for mozrunner 09:30:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:30:23 INFO - Running setup.py install for mozscreenshot 09:30:23 INFO - Running setup.py install for moztest 09:30:23 INFO - Running setup.py install for mozversion 09:30:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:30:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:30:23 INFO - Cleaning up... 09:30:23 INFO - Return code: 0 09:30:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30: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')]} 09:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30: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')]} 09:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:23 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 0x108991490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10896e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd510585610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b59f0>, '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 0x108614db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088a88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/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.djHPg5n9pt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:30:23 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 09:30:23 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 09:30:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/Render', 09:30:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:23 INFO - 'HOME': '/Users/cltbld', 09:30:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:23 INFO - 'LOGNAME': 'cltbld', 09:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:23 INFO - 'MOZ_NO_REMOTE': '1', 09:30:23 INFO - 'NO_EM_RESTART': '1', 09:30:23 INFO - 'PAGER': '/bin/cat', 09:30:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:23 INFO - 'PWD': '/builds/slave/test', 09:30:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:23 INFO - 'SHELL': '/bin/bash', 09:30:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djHPg5n9pt/Listeners', 09:30:23 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:30:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:23 INFO - 'USER': 'cltbld', 09:30:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:23 INFO - 'XPC_FLAGS': '0x0', 09:30:23 INFO - 'XPC_SERVICE_NAME': '0', 09:30:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:30:24 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-w0YJxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:30:24 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-0zr1ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:30:24 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-MEiKHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:30:24 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-e1FW56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:30:24 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)) 09:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:30:24 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-THsQKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:30:24 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)) 09:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:30:24 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-h234Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:30:24 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)) 09:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:30:24 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-HlqrO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:30:24 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)) 09:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:30:24 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-D8QXHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:30:24 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)) 09:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:30:24 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-U4cnRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:30:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-tH3yMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:30:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-qb17E8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:30:25 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)) 09:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:30:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-DHMpoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:30:25 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)) 09:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:30:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-KEFlFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:30:25 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)) 09:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:30:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-0SM0Bw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:30:25 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)) 09:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-Sk6IYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:30:25 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)) 09:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:30:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-LCrzvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:30:25 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)) 09:30:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:30:25 INFO - Running setup.py (path:/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/pip-WFucx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:30:25 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)) 09:30:25 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)) 09:30:25 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)) 09:30:25 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)) 09:30:25 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)) 09:30:25 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)) 09:30:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:30:28 INFO - Downloading blessings-1.5.1.tar.gz 09:30:28 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 09:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:30:28 INFO - Installing collected packages: blessings 09:30:28 INFO - Running setup.py install for blessings 09:30:28 INFO - Successfully installed blessings 09:30:28 INFO - Cleaning up... 09:30:28 INFO - Return code: 0 09:30:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:30:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:28 INFO - Reading from file tmpfile_stdout 09:30:28 INFO - Current package versions: 09:30:28 INFO - blessings == 1.5.1 09:30:28 INFO - blobuploader == 1.2.4 09:30:28 INFO - docopt == 0.6.1 09:30:28 INFO - manifestparser == 1.1 09:30:28 INFO - mozInstall == 1.12 09:30:28 INFO - mozcrash == 0.16 09:30:28 INFO - mozdebug == 0.1 09:30:28 INFO - mozdevice == 0.47 09:30:28 INFO - mozfile == 1.2 09:30:28 INFO - mozhttpd == 0.7 09:30:28 INFO - mozinfo == 0.9 09:30:28 INFO - mozleak == 0.1 09:30:28 INFO - mozlog == 3.1 09:30:28 INFO - moznetwork == 0.27 09:30:28 INFO - mozprocess == 0.22 09:30:28 INFO - mozprofile == 0.27 09:30:28 INFO - mozrunner == 6.11 09:30:28 INFO - mozscreenshot == 0.1 09:30:28 INFO - mozsystemmonitor == 0.0 09:30:28 INFO - moztest == 0.7 09:30:28 INFO - mozversion == 1.4 09:30:28 INFO - psutil == 3.1.1 09:30:28 INFO - requests == 1.2.3 09:30:28 INFO - wsgiref == 0.1.2 09:30:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:30:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:30:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:30:28 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 0x108991490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10896e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd510585610>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088b59f0>, '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 0x108614db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088a88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/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.djHPg5n9pt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:30:28 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 09:30:28 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 09:30:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/Render', 09:30:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:28 INFO - 'HOME': '/Users/cltbld', 09:30:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:28 INFO - 'LOGNAME': 'cltbld', 09:30:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:28 INFO - 'MOZ_NO_REMOTE': '1', 09:30:28 INFO - 'NO_EM_RESTART': '1', 09:30:28 INFO - 'PAGER': '/bin/cat', 09:30:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:28 INFO - 'PWD': '/builds/slave/test', 09:30:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:28 INFO - 'SHELL': '/bin/bash', 09:30:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djHPg5n9pt/Listeners', 09:30:28 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:30:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:28 INFO - 'USER': 'cltbld', 09:30:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:28 INFO - 'XPC_FLAGS': '0x0', 09:30:28 INFO - 'XPC_SERVICE_NAME': '0', 09:30:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:30:28 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)) 09:30:28 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)) 09:30:28 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)) 09:30:28 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)) 09:30:28 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)) 09:30:28 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)) 09:30:28 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)) 09:30:28 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)) 09:30:28 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)) 09:30:28 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)) 09:30:28 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)) 09:30:28 INFO - Cleaning up... 09:30:28 INFO - Return code: 0 09:30:28 INFO - Running post-action listener: _resource_record_post_action 09:30:28 INFO - Running post-action listener: _start_resource_monitoring 09:30:29 INFO - Starting resource monitoring. 09:30:29 INFO - ##### 09:30:29 INFO - ##### Running install step. 09:30:29 INFO - ##### 09:30:29 INFO - Running pre-action listener: _resource_record_pre_action 09:30:29 INFO - Running main action method: install 09:30:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:30:29 INFO - Reading from file tmpfile_stdout 09:30:29 INFO - Detecting whether we're running mozinstall >=1.0... 09:30:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:30:29 INFO - Reading from file tmpfile_stdout 09:30:29 INFO - Output received: 09:30:29 INFO - Usage: mozinstall [options] installer 09:30:29 INFO - Options: 09:30:29 INFO - -h, --help show this help message and exit 09:30:29 INFO - -d DEST, --destination=DEST 09:30:29 INFO - Directory to install application into. [default: 09:30:29 INFO - "/builds/slave/test"] 09:30:29 INFO - --app=APP Application being installed. [default: firefox] 09:30:29 INFO - mkdir: /builds/slave/test/build/application 09:30:29 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'] 09:30:29 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 09:30:59 INFO - Reading from file tmpfile_stdout 09:30:59 INFO - Output received: 09:30:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:30:59 INFO - Running post-action listener: _resource_record_post_action 09:30:59 INFO - ##### 09:30:59 INFO - ##### Running run-tests step. 09:30:59 INFO - ##### 09:30:59 INFO - Running pre-action listener: _resource_record_pre_action 09:30:59 INFO - Running main action method: run_tests 09:31:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:31:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:31:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:31:00 INFO - 2015-11-24 09:31:00.012 screenresolution[1646:7480] starting screenresolution argv=screenresolution get 09:31:00 INFO - 2015-11-24 09:31:00.014 screenresolution[1646:7480] Display 0: 1600x1200x32@60 09:31:00 INFO - 2015-11-24 09:31:00.019 screenresolution[1647:7485] starting screenresolution argv=screenresolution list 09:31:00 INFO - Available Modes on Display 0 09:31:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:31:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:31:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:31:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:31:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:31:00 INFO - Intel Iris: 09:31:00 INFO - Chipset Model: Intel Iris 09:31:00 INFO - Type: GPU 09:31:00 INFO - Bus: Built-In 09:31:00 INFO - VRAM (Dynamic, Max): 1536 MB 09:31:00 INFO - Vendor: Intel (0x8086) 09:31:00 INFO - Device ID: 0x0a2e 09:31:00 INFO - Revision ID: 0x0009 09:31:00 INFO - Displays: 09:31:00 INFO - Display: 09:31:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:31:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:31:00 INFO - Display Serial Number: 1600x1200 60 09:31:00 INFO - Main Display: Yes 09:31:00 INFO - Mirror: Off 09:31:00 INFO - Online: Yes 09:31:00 INFO - Rotation: Supported 09:31:00 INFO - Return code: 0 09:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:31:00 INFO - Python 2.7.3 09:31:00 INFO - Return code: 0 09:31:00 INFO - grabbing minidump binary from tooltool 09:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:31:00 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 0x1088b59f0>, '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 0x108614db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1088a88c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:31:00 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 09:31:00 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 09:31:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:31:00 INFO - Return code: 0 09:31:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:31:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:31:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:31:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:31:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:31:00 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/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--webServer', 'localhost'] in /builds/slave/test/build 09:31:00 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/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0027 --webServer localhost 09:31:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LaKIJGmQZh/Render', 09:31:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:00 INFO - 'HOME': '/Users/cltbld', 09:31:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:00 INFO - 'LOGNAME': 'cltbld', 09:31:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:31:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:00 INFO - 'MOZ_NO_REMOTE': '1', 09:31:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:31:00 INFO - 'NO_EM_RESTART': '1', 09:31:00 INFO - 'PAGER': '/bin/cat', 09:31:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:00 INFO - 'PWD': '/builds/slave/test', 09:31:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:31:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:00 INFO - 'SHELL': '/bin/bash', 09:31:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djHPg5n9pt/Listeners', 09:31:00 INFO - 'TMPDIR': '/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/', 09:31:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:00 INFO - 'USER': 'cltbld', 09:31:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:00 INFO - 'XPC_FLAGS': '0x0', 09:31:00 INFO - 'XPC_SERVICE_NAME': '0', 09:31:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:00 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/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0027', '--webServer', 'localhost'] with output_timeout 3600 09:31:00 INFO - mozversion INFO | application_buildid: 20151124083121 09:31:00 INFO - mozversion INFO | application_changeset: d516d82f29a2636c5834c7f3c932025b8e85a8ad 09:31:00 INFO - mozversion INFO | application_display_name: Nightly 09:31:00 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:31:00 INFO - mozversion INFO | application_name: Firefox 09:31:00 INFO - mozversion INFO | application_remotingname: firefox 09:31:00 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:31:00 INFO - mozversion INFO | application_vendor: Mozilla 09:31:00 INFO - mozversion INFO | application_version: 45.0a1 09:31:00 INFO - mozversion INFO | platform_buildid: 20151124083121 09:31:00 INFO - mozversion INFO | platform_changeset: d516d82f29a2636c5834c7f3c932025b8e85a8ad 09:31:00 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:31:00 INFO - mozversion INFO | platform_version: 45.0a1 09:31:00 INFO - 2015-11-24 09:31:00,576 DEBUG : using testdate: 1448386260 09:31:00 INFO - 2015-11-24 09:31:00,576 DEBUG : actual date: 1448386260 09:31:00 INFO - 2015-11-24 09:31:00,932 INFO : starting webserver on 'localhost:49272' 09:31:00 INFO - 2015-11-24 09:31:00,933 INFO : Starting test suite t-yosemite-r7-0027 09:31:00 INFO - 2015-11-24 09:31:00,933 INFO : Starting test dromaeo_css 09:31:00 INFO - 2015-11-24 09:31:00,933 DEBUG : operating with platform_type : mac_ 09:31:00 INFO - 2015-11-24 09:31:00,934 INFO : Initialising browser for dromaeo_css test... 09:31:00 INFO - 2015-11-24 09:31:00,947 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpcqXMkA/profile http://localhost:49272/getInfo.html 09:31:03 INFO - 2015-11-24 09:31:03,135 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:31:03 INFO - 2015-11-24 09:31:03,135 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:31:03 INFO - 2015-11-24 09:31:03,135 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:31:03 INFO - 2015-11-24 09:31:03,135 DEBUG : BROWSER_OUTPUT: __metrics 09:31:03 INFO - 2015-11-24 09:31:03,151 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:31:03 INFO - 2015-11-24 09:31:03,787 INFO : Browser initialized. 09:31:03 INFO - 2015-11-24 09:31:03,787 INFO : Running cycle 1/1 for dromaeo_css test... 09:31:03 INFO - 2015-11-24 09:31:03,787 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpcqXMkA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:31:15 INFO - 2015-11-24 09:31:15,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 226181120 09:31:15 INFO - 2015-11-24 09:31:15,654 DEBUG : BROWSER_OUTPUT: 09:32:06 INFO - 2015-11-24 09:32:06,885 DEBUG : BROWSER_OUTPUT: 1448386326882 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] 09:34:17 INFO - 2015-11-24 09:34:17,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 09:34:19 INFO - 2015-11-24 09:34:19,104 DEBUG : BROWSER_OUTPUT: RSS: Main: 336764928 09:34:19 INFO - 2015-11-24 09:34:19,104 DEBUG : BROWSER_OUTPUT: 09:37:21 INFO - 2015-11-24 09:37:21,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 09:37:22 INFO - 2015-11-24 09:37:22,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 363589632 09:37:22 INFO - 2015-11-24 09:37:22,449 DEBUG : BROWSER_OUTPUT: 09:40:24 INFO - 2015-11-24 09:40:24,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 09:40:25 INFO - 2015-11-24 09:40:25,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 340803584 09:40:25 INFO - 2015-11-24 09:40:25,070 DEBUG : BROWSER_OUTPUT: 09:43:27 INFO - 2015-11-24 09:43:27,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 09:43:27 INFO - 2015-11-24 09:43:27,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 327114752 09:43:27 INFO - 2015-11-24 09:43:27,671 DEBUG : BROWSER_OUTPUT: 09:46:30 INFO - 2015-11-24 09:46:30,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 09:46:31 INFO - 2015-11-24 09:46:31,527 DEBUG : BROWSER_OUTPUT: RSS: Main: 325931008 09:46:31 INFO - 2015-11-24 09:46:31,527 DEBUG : BROWSER_OUTPUT: 09:49:34 INFO - 2015-11-24 09:49:34,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 09:49:34 INFO - 2015-11-24 09:49:34,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 377589760 09:49:34 INFO - 2015-11-24 09:49:34,544 DEBUG : BROWSER_OUTPUT: 09:49:34 INFO - 2015-11-24 09:49:34,544 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:49:34 INFO - 2015-11-24 09:49:34,544 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:49:34 INFO - 2015-11-24 09:49:34,544 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:49:34 INFO - 2015-11-24 09:49:34,545 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:49:34 INFO - 2015-11-24 09:49:34,545 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3443.466262729277;3479.095435186851;3522.8766993155227;3533.4699795030742;3563.8396272167756;5435.592330575213;5840.824775256739;5950.226470558827;5966.224390829191;6016.699165041747;5873.471387575118;5874.383189765077;5894.734736936837;5914.970425147879;6046.365131661179;5243.528082472577;5261.710605916673;5291.391489978663;5330.680159190461;5407.3781515125675;5376.032314183445;5401.4868587484125;5420.647657902244;5443.374011988612;5449.482299181572;5152.07262692717;5256.81601143962;5277.076511610453;5281.234221037928;5407.432219616942;5177.145770947826;5307.522322990911;5314.973425132888;5315.6013299002725;5332.466753324676;5251.76367063483;5309.814156504543;5324.201369794523;5331.760070796823;5341.893162136736;5879.7648094076185;5893.14549390336;5917.171595976567;5926.703664816742;5945.078512830518;6201.7519299228425;6204.596701214452;6300.873982520324;6317.905231421532;6336.651484168369;6369.777057803001;6377.904331435032;6381.425671689523;6390.265119511269;6394.968025159891;5088.414832294259;6053.303870054912;6134.263888333384;6137.324894261627;6163.845903852395;6199.504039676815;6301.936980630227;6367.777127800505;6368.10846481493;6408.61548307103;6311.652859092794;6370.0763389308295;6376.553641245068;6381;6397.040443933447;6348.365163483615;6348.714307856158;6362.459190968727;6365.936340636535;6372.872542549123;6197.070439434121;6204.7828326008375;6296.5592408531875;6334.873302533923;6348.587341822767;6320.683965801783;6335;6335.11308416822;6337.841553961096;6355.0785136155;5042.445331013586;5085.593152547787;5109.642325037212;5111.846644600668;5158.329417175818;3788.7158463115375;4446.466424029137;4487.685861989695;4559.088182363541;4583.702059366197;5907.527397808165;5925.111233315038;5945.3757355477055;5950.940490595125;5952.226210592682;6376.649284289409;6381.744730210832;6387.520935929824;6389.552731308764;6403.391677790602;5654.6324488908085;5725.742341594639;5801.767929282782;5821.476067153976;5877.089051197071;5545.556355491632;5571.4150014248735;5573.916391254134;5592.189132575753;5598.300212473441;6439.195100612424;6451.967740161269;6523.64119973406;6547.312532184147;6552.213734351908;6172.105044768394;6202.28673702512;6288.930881750022;6289.276733175743;6313.589616674902;6346.365363463617;6349.984002559569;6363.5863668861375;6374.394432528902;6435.356464353715;5219.4780521947505;6267.592606480564;6269.749210031548;6275.5920865145445;6309.779157729457;6156.507479401726;6232.626042437469;6270.968645156928;6304.6847657617855;6363.077353783768;6291.811245662638;6312.58968167086;6338.080978258219;6351.618902865843;6352.142460767737;6319.6208227506495;6333.334999824952;6338.302786693553;6349.49204063683;6354.93645063562;5908.645481271137;6052.251739310725;6091.086337049478;6170.074488826712;6198.442140207403;6141.117811340085;6217.285012223652;6251.249850018027;6258.217722784652;6296.024116261987;6024.939750602438;6226.346233645402;6243.250809902841;6256.31180570146;6265.937340626718 09:49:34 INFO - 2015-11-24 09:49:34,546 DEBUG : BROWSER_OUTPUT: |1;ext.html;543.1716632135995;549.4121290219464;576.4149388370807;598.2014011294921;621.7140115546848;32648.347033059326;33131.006069817915;42263.78868105663;42688;42791.57208427915;44521.88695282619;44856.87857803557;44924.55075449245;45071;45358.0928381433;9778.559964801583;9942.652007179713;9971.40457526796;9977.850332244985;9988.700338989842;8814.427062240966;8915.643374265053;8919.910800892005;11938.641840744747;12064.457099430503;11830.290182589073;11900.166988310822;11907.464164112593;11919.344436056013;11920.523179072827;8876.911230887737;11773.7645247095;11896.821547676791;11897.226680265756;11997.160198786089;8686.174813392718;8796.56017199144;8811.559422028873;8824.69113581028;11785.941070294679;41447;41898.53355132586;41901.60033196532;41926.371104433456;41970.790146049076;3201.103690966533;3250.236194494292;3293.5389045533643;3418.3334249821296;3490.0925759302763;28881;29552.852235738683;30033.69966300331;30306;30583.694163058306;2833.3483298841384;2896.8551572421293;2897.1163795042503;2927.809692369989;3039.5136778115616;510285;514941;515146.42426788004;515726;517084;72491;72816.27183728201;72819.63590182015;72847;73011.2698873015;76753;77042.84435733469;77273.61363193148;77309;77415;15239.314230859638;16858.494245172664;17005.659886802194;17048.062356570506;17049.7442538362;11282.774344513064;11323.980841724284;11324.32054076758;11334.60328888485;11339.603113891138;17717.7342339865;18377.67182930378;22524.54950900973;23240.883795580914;23505.29484115479;7942.483738556975;9793.510324483746;9794.510274486247;9798.216142708567;9842.950785246028;745.9254074592606;902.1384577728254;983.4541829284816;985.3299756165733;1057.799018186542;22307.88846055792;29171;29653.258668533028;29790.615955973797;30330;1033.6588925654517;1085.9511321990528;1100.763335882789;1109.2197023776882;1158.212415557429;15323.770143447857;15536.689266214613;15609.453669121527;15654.433257551107;15875.444359447363;676877;680573;681138;682886;684882;55501;63984;64074.35925640777;64180.03729944055;64185.35814641794;1309.6202101390681;1332.027619837524;1454.3382760844001;1539.8075240594926;1584.3741722019738;30656.540151898185;30802;30802;31141.688583114785;31362.21594460157;50475;51846.48153518417;52298;52466;52485.95028099493;375363;672785;675127;675298;676854;33792.3241535163;34430.87298613713;34677.91932484059;34758.30483390267;34833.65166348304;45822;46414.07171856611;46872.7656361716;47783.52216477791;47854.28218576794;34821.477677834344;36970.8151459241;38029;39016.80491597524;39090.609093909836;37444.81277593595;37599.624003759614;38387.80806096063;38567.614323857524;38657;37602.43596346112;38469.6153038466;38637.420438694004;38639;38669.41995870008;33290.00129996104;33780.66219337775;34202.82898585491;34439.82780086083;34741.65258347485;23991.880040599684;24913;25157.748422516273;25361.365965850262;25394 09:49:34 INFO - 2015-11-24 09:49:34,549 DEBUG : BROWSER_OUTPUT: |2;jquery.html;358.7919006975953;361.2540104683828;363.2227034146928;365.48466662006575;365.7659098177167;16200.513984580452;16920.4077857275;20035.59928801423;20438.2846600369;21133.365999020014;20937.581248375023;21030.474238144056;22238.444038898997;22331.330060098182;22335.218267360644;5694.202811606378;6415.06981487684;6606.207255129391;6607.438367738748;6607.834804129911;4557.589816916477;4632.14305353509;6448.967755161218;7137.286271372847;7381.778546643583;7236.312550307739;7370.631468426584;7441.367483763886;7450.143233528132;7459.664315105806;7342.706291748324;7395.556266623993;7398.519096258726;7405.962970185168;7409.296116868889;6905.585664860125;7120.789465790828;7141.214466408691;7146.964265178641;7152.141742990822;20906.95465226748;20939.5812083759;25180.622290665655;27406.76669549875;28151.873925042975;2271.9772802272096;2355.8586484810794;2445.339758265276;2475.282168171228;2576.780973617245;15370.00094993833;15903.52289431319;15984.520464386087;16079.276432560562;16304.918475407665;1815.8728888977778;1843.732658764485;1867.7478540397144;1884.8303652671189;1886.368066697658;117303.82696173014;118063.81936180615;118587;118867.81132188653;122387.38806306;18707.625847483247;19049.71425428592;19141.521461963563;19201.423957281302;19203.90398048001;28071;28150.85924570364;28158.85920570384;28174.87300507998;28245.293867653472;10313.226508011929;10328.793424131476;10365.844512332322;10372.222083343779;10420.218483613759;7307.232740562271;7580.886286705704;8655.610497527627;8750.912490875136;8790.120987901159;6677.383904162473;8612.698555550525;8623.655053797778;8745.868811967826;8762.474251544927;1426.9500567480088;1568.192380923825;1862.850971922243;1863.8881667100018;1865.291189348039;859.4542465534431;869.1265278395173;906.1165363770403;919.8252332057021;1011.2365164300905;16062.598435039217;16841.831581684026;20209.94624058466;21058.052387642594;21423.785762142492;956.4022485946283;975.6097560975667;1000.3197825478744;1045.362328979322;1064.6380230721593;11006.779864402668;11111.666650000512;11851.88148118525;11854.229475084092;11854.762904742029;706811;734751;736173;742747;762992;112743;115094;115652;117101;119533.40233298778;986.7582442301682;1212.9818052729215;1219.6463025722442;1224.6632176151809;1226.533917111492;18257.360992365204;18553.072346382898;18980.57645676552;19051.904740476763;19422.514437139183;47976.04047919092;51025.23462147996;51105;51182;51207.2318915224;68129.3187068123;68419.65790171217;68432.63134737377;69534;70308.6484567574;8113.472624279403;9914.454704991294;9917.355371900803;10061.295709300279;10097.899021009696;20107;20315.8984205078;20404.877731724304;20618.865962372212;20676.379708608765;15162.772558411412;15522.611934701723;15785.210739462751;15956.042637441791;16277.593060173116;12576.559820406243;12828.935855320664;15094.39622415135;15293.464728734441;15398.46105386306;15749.763753543477;15804.841951580336;16079.196040198178;16100.516984490485;16473.67052658964;9421.670241541513;9643.710688679352;9719.514024298898;9740.853887191555;9742.659006934724;10849.026095176749;15150.090994540364;15179.696406071596;15488.767668484756;15533.922330388275 09:49:34 INFO - 2015-11-24 09:49:34,551 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1581.1303782919392;1584.8652864506516;1705.5139285303692;1880.4640677406942;1888.9905550472245;6963.686634101465;7629.1989341119215;8286.792830179249;8647.394682372236;8675.349348798849;8351.707690230844;8504.19210175034;8562.91437085629;8563.443376180543;8575.699850505234;2361.445060410802;2380.678608387863;2382.8927698253533;2383.3088404362716;2383.4041489627593;2378.203301893868;2399.244238065004;2419.4314336130997;2426.3327584914114;2427.8543287402813;2351.95296094078;2376.8811559422047;2381.095183830142;2381.499885024147;2387.689600351952;2333.603287441122;2360.126753101355;2370.051979208322;2371.762823717623;2384.3681424422543;2355.8468699534474;2377.2036367816804;2389.0921449848947;2389.4862604539935;2396.065534441569;7688.923110768933;8431.072582016035;8462.2383985441;8477.448965817202;8485.618147183392;4386.793631751262;4777.474477807438;4824.734639594821;4846.224604063368;5228.398734145546;3478.843452044664;3555.253396786678;3589.10272431892;3593.94609080864;3624.6012938576737;1040.238167664851;1060.7295139739394;1070.3203465799195;1071.539238127605;1078.9298695584762;11222.214444988855;11263.493142808593;11277.097832173406;11280.548778048867;11289.266197697123;4701.858944231679;4710.552497512731;4759.286107083965;4775.617950563947;4777.092352453023;9819.852702209473;9851.50742462874;9856.457894815854;9864.950675246579;9865.901340986642;5306.328506520434;5311.893762124736;5320.866978325573;5323.813666521653;5328.387235467971;4123.9381409278885;4844.878878028007;4848.8787780305065;4850.466448690641;4852.296417019513;3286.622038465607;3669.5963444021136;3750.7374483785875;3755.7746535207975;3775.905602359963;1227.098082909061;1233.8889499945049;1235.5552001279532;1244.0980289290374;1245.7383949370553;1395.9371828267751;1411.2731943049337;1413.2107495064201;1428.757111291083;1437.1377173695698;7935.769955656767;7992.440529163019;7995.920040799634;8005.759827205193;8023;427.50196021634446;432.60416718702663;507.0821812519352;507.32272416323883;517.4230732732975;5954.225950626391;6097.054956481752;6179.721912513947;6202.534809889276;6207.348228435949;9023.323250756088;10051.547680354402;10302.175825933908;10305.536250868729;10387.117095046855;10026.147777438853;10122.139618132394;10124.240681948737;10223.335483193569;10293.073623373932;7900.933373994552;7987.201279871966;8065.83868322642;8076.636551355321;8103.31121854649;7608.467407281437;7739.845203095794;7773.92226077732;7783.571903545133;7790.987171667874;9014.954925225333;9075.682351117679;9162.862557061782;9181.954090229507;9295.535223238676;9179.17387435134;9442.433453992782;9456.05439456049;9568.95215523918;9580.041995800364;7059.294070593105;7267.818304542428;7340.265973402617;7370;7388.261173882784;7144.285571442814;7866.8593054008;7997.200279971957;8091.757247282591;8145.959270203611;7451.478396512409;7542.547447153188;7575.181956330552;7636.8472630548185;7694.269044440769;7481;7483.176850546544;7515.887261690969;7606.885896711665;7616.162222155669;7616.428767842323;7659.88510172359;7665.731699390718;7668.731594394392;7677.846443071219;5892.234009578728;6941.0629565010095;6970.65146742671;6980.965095174694;6986.091808065123;7026.754063607749;7076.575405475688;7083.68123434457;7084.504084714021;7087.893681594677 09:49:34 INFO - 2015-11-24 09:49:34,552 DEBUG : BROWSER_OUTPUT: |4;prototype.html;269.9149767823136;330.91561651778795;334.36213991769546;334.44816053511687;335.5604158552297;6800.761973330935;6912.619805910673;6951.200611929629;6974.546654467463;7051.753188638399;5500.752466139023;6903;6948.6873090710915;6975.441964642829;6998;5067.746612669361;5110.620132564205;5117.948820511803;5120.3855537335385;5125.974370128163;4107.54816970133;4185.476815398075;4804.063207674505;4855.902881942359;5116.539511443969;4932.53140951609;4937.580305674022;5041.495850414965;5044.924326135111;5058.924116138261;5000.524950129732;5014;5025.070361983045;5032.169692000815;5045.117104506697;4293.592108749664;4296.226679197744;4297.828086876521;4305.138972205571;4305.289627211507;5929.377415371367;6145.385461453863;6359.282993591704;6644.534882558223;6664.100346453215;5994.8501287467725;6011.098335249704;6013.098035294697;6013.1581578579035;6014.51883849291;5958.851028724273;7366.337029667302;7374.926250737478;7386.815329616803;7387.298206670358;4646.210144275481;4872.171730805771;4876.512348765131;4884.120858245515;4885.218365061573;7883.290503854623;7963.3231175350165;7964;7965.960170199112;7970;4834.057358814997;4842.927356089662;4843.6367272454;4845.418549773979;4855.271709243641;4715.622750180046;4739.620830333565;4781.928271075936;4785.282207668808;4945.23348880924;5957.821265362046;5963.612365196248;5977.117208079441;5980.372060933626;5986.99435689049;7509.173990861001;7510.324070833542;7525.736599219001;7528.51064680794;7534.397248220239;1655.8840881138447;1685.2500637216567;1703.9829601704073;1710.1791140252749;1710.880238383326;916.5646317998898;1065.7122576904192;1080.2924084724518;1084.2301965604352;1086.2884810449168;6942.7222911084;6949.339812717783;6952.130983627047;6954.3393377629045;6979.406750426169;6239.844003899848;7713.190115037953;7722.575258360844;7732.922670773332;7742.574158421341;5754.539636829044;6630.5027122965;6916.515843890879;6938.8612227756175;6955.582665040114;4073.327900896319;4114.958850411457;4116.464859568297;4120.75275483472;4134.813933373005;5871;7941.166177551274;7958.880616790637;7966.920330796734;7976.401769867283;5879.089850524018;7972.960135199403;8020.478668886503;8145.551994640233;8156.67373305073;8133.674653013932;8136.75589732309;8140.959295203605;8167.469114507538;8177.632006559719;6338.58799178052;7634.732784352521;7864.134945156143;7874.409419293462;7880.093789214314;5529.142982837667;6213.409726076015;7437.628118594157;7612.657430415756;7696.230376962259;8091.190880911861;8093.109757926741;8100.635471403919;8116.75649730509;8119;4645.74448405341;4731.077439899186;4740.810367585258;4800.0639875224;4849.878753031202;7764.9223507766455;7767.53394796314;7768.728094516665;7786.26030527099;7791.688332466638;7475.962620186864;7485.4385921055045;7487.951686763967;7502.099748030053;7506.58713770726;7280.854382912206;7483.289087536676;7547.358474529727;7549.282818132268;7585.810354740955;7176.928230717626;7365;7368.263173682589;7368.852622947404;7373.520721153108;6488;7290.781276561712;7546.584937828472;7557.584332861746;7575.583342916192;7356.889646655198;7363.263673632594;7366.116066072105;7367.189609143097;7379.040724705754 09:49:34 INFO - 2015-11-24 09:49:34,555 DEBUG : BROWSER_OUTPUT: |5;yui.html;718.8310746974461;775.9728409505667;811.7686459359084;823.2220551578757;834.370050611788;15068.698626027473;15365.692686146283;15376.923115384407;15388.99971501853;15405.460808871692;14227.78658320126;14363.210023448706;14365.209913454783;14385.92807035966;14451.349689263981;756.440234226671;764.2853931573968;764.6979443119965;939.1313035442223;947.5783276441986;941.3316545252878;948.2177203806853;963.4604621411996;963.9614415423374;966.3042609321277;992.4591097851688;1010.1312870930993;1013.3413281367134;1013.9036791504832;1015.3349556040769;790.3124281874748;802.0655935834745;973.8295798235351;993.2500961773886;1009.1724785675749;744.2854859335044;751.1211882097904;753.4198667026359;754.2570567990525;754.2608243920934;14977.251137443085;15180.316885740169;15187;15206.315715792816;15229.238538073163;12664.873351266462;12962.611121666365;13116.344182790917;13322.467101315935;13445.798313025312;10171.64399246023;10342.586296548128;10391.220658450646;10521.473926303654;10710.732231694192;3483.8780642677384;3605.5312809334882;3644.3804553226014;3684.778913265213;3747.7938713370754;74023.51952960965;78878;80141.59929200375;80430.59784701097;80591;9213.216876565433;9521.952390238004;9776.364536305118;9834.311598188202;10143.543540540693;20921.581568368547;21158.894205528875;21525;21860.125594976023;21891.12435502594;7122.03852479919;7195.172555156224;7204.855902881913;7320.267973202744;7323.304286092813;3851.5763266040713;3864.729468937204;3915.7454765440157;3917.9804100979313;3950.2889479893897;3519.102628829632;3566.7859928404378;3567.8929632111076;3568.518250036264;3574.767640103385;631.4601016131141;633.6261605652687;633.8415396150963;654.2737561306946;660.0528241972785;478.62395612613733;495.7248726956574;505.69152816781735;520.8229401552519;601.9879602408015;8775.824483510294;9370.625174992923;9390.812183756287;9401.153896149379;9557.856632150524;426.43497365990186;505.91146549353715;526.6734624532737;588.7291845750917;613.96009259398;3927.4501569780255;4060.898477538085;4069.593040695907;4132.586741325843;4189;100596;102363.4881825586;102378;102478.48760756297;103386.48306758418;86857;87141.12858871456;87695.56152219199;88107.55946220228;88733.55633221792;67640;68491;74755.62622186964;75404.62297688477;75942;8406.789830254293;8549.358798090043;8732.607032683418;9076.41003334781;9147.22248608849;52026.99999999849;52585;52728.73635631951;53929.11248106298;54726.45273547373;78180.60909695415;78213.2178678206;78225.60887195528;78283.60858195672;79765.60117199377;11172.55309787632;11275.801766701683;11280.548778049115;11411.714707132056;11691.878980891855;12029.879701202875;12201.267923924594;12333.136680432643;12346.259224446561;12457.935785264472;11751.70841685863;11773;11874.525018999144;12037.398130093636;12040.879591203975;11689.766204676029;11707.2975621463;11955.55953411132;11969.64091077269;11975.341356225492;11161.55353785872;11275.943620282174;11479.417131145425;11736.354500502553;12338.136330456782;8296.543690097102;9684.612615495302;9729.557842226319;10306.484675766033;10475.842862357224;9352.485613291063;9550.331476796557;10161.542730576994;10173.237007224636;10200.591976320864 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1369 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: __startTimestamp1448387374541__endTimestamp 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5873.60 Median:6170.07 stddev:655.42 (10.6%) stddev-sans-first:629.10 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: Values: 3443.5 3479.1 3522.9 3533.5 3563.8 5435.6 5840.8 5950.2 5966.2 6016.7 5873.5 5874.4 5894.7 5915.0 6046.4 5243.5 5261.7 5291.4 5330.7 5407.4 5376.0 5401.5 5420.6 5443.4 5449.5 5152.1 5256.8 5277.1 5281.2 5407.4 5177.1 5307.5 5315.0 5315.6 5332.5 5251.8 5309.8 5324.2 5331.8 5341.9 5879.8 5893.1 5917.2 5926.7 5945.1 6201.8 6204.6 6300.9 6317.9 6336.7 6369.8 6377.9 6381.4 6390.3 6395.0 5088.4 6053.3 6134.3 6137.3 6163.8 6199.5 6301.9 6367.8 6368.1 6408.6 6311.7 6370.1 6376.6 6381.0 6397.0 6348.4 6348.7 6362.5 6365.9 6372.9 6197.1 6204.8 6296.6 6334.9 6348.6 6320.7 6335.0 6335.1 6337.8 6355.1 5042.4 5085.6 5109.6 5111.8 5158.3 3788.7 4446.5 4487.7 4559.1 4583.7 5907.5 5925.1 5945.4 5950.9 5952.2 6376.6 6381.7 6387.5 6389.6 6403.4 5654.6 5725.7 5801.8 5821.5 5877.1 5545.6 5571.4 5573.9 5592.2 5598.3 6439.2 6452.0 6523.6 6547.3 6552.2 6172.1 6202.3 6288.9 6289.3 6313.6 6346.4 6350.0 6363.6 6374.4 6435.4 5219.5 6267.6 6269.7 6275.6 6309.8 6156.5 6232.6 6271.0 6304.7 6363.1 6291.8 6312.6 6338.1 6351.6 6352.1 6319.6 6333.3 6338.3 6349.5 6354.9 5908.6 6052.3 6091.1 6170.1 6198.4 6141.1 6217.3 6251.2 6258.2 6296.0 6024.9 6226.3 6243.3 6256.3 6265.9 09:49:34 INFO - 2015-11-24 09:49:34,556 DEBUG : BROWSER_OUTPUT: 09:49:34 INFO - 2015-11-24 09:49:34,557 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:74484.06 Median:37815.72 stddev:163675.59 (432.8%) stddev-sans-first:164040.60 09:49:34 INFO - 2015-11-24 09:49:34,558 DEBUG : BROWSER_OUTPUT: Values: 543.2 549.4 576.4 598.2 621.7 32648.3 33131.0 42263.8 42688.0 42791.6 44521.9 44856.9 44924.6 45071.0 45358.1 9778.6 9942.7 9971.4 9977.9 9988.7 8814.4 8915.6 8919.9 11938.6 12064.5 11830.3 11900.2 11907.5 11919.3 11920.5 8876.9 11773.8 11896.8 11897.2 11997.2 8686.2 8796.6 8811.6 8824.7 11785.9 41447.0 41898.5 41901.6 41926.4 41970.8 3201.1 3250.2 3293.5 3418.3 3490.1 28881.0 29552.9 30033.7 30306.0 30583.7 2833.3 2896.9 2897.1 2927.8 3039.5 510285.0 514941.0 515146.4 515726.0 517084.0 72491.0 72816.3 72819.6 72847.0 73011.3 76753.0 77042.8 77273.6 77309.0 77415.0 15239.3 16858.5 17005.7 17048.1 17049.7 11282.8 11324.0 11324.3 11334.6 11339.6 17717.7 18377.7 22524.5 23240.9 23505.3 7942.5 9793.5 9794.5 9798.2 9843.0 745.9 902.1 983.5 985.3 1057.8 22307.9 29171.0 29653.3 29790.6 30330.0 1033.7 1086.0 1100.8 1109.2 1158.2 15323.8 15536.7 15609.5 15654.4 15875.4 676877.0 680573.0 681138.0 682886.0 684882.0 55501.0 63984.0 64074.4 64180.0 64185.4 1309.6 1332.0 1454.3 1539.8 1584.4 30656.5 30802.0 30802.0 31141.7 31362.2 50475.0 51846.5 52298.0 52466.0 52486.0 375363.0 672785.0 675127.0 675298.0 676854.0 33792.3 34430.9 34677.9 34758.3 34833.7 45822.0 46414.1 46872.8 47783.5 47854.3 34821.5 36970.8 38029.0 39016.8 39090.6 37444.8 37599.6 38387.8 38567.6 38657.0 37602.4 38469.6 38637.4 38639.0 38669.4 33290.0 33780.7 34202.8 34439.8 34741.7 23991.9 24913.0 25157.7 25361.4 25394.0 09:49:34 INFO - 2015-11-24 09:49:34,558 DEBUG : BROWSER_OUTPUT: 09:49:34 INFO - 2015-11-24 09:49:34,558 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:39997.11 Median:21044.26 stddev:121230.10 (576.1%) stddev-sans-first:121533.64 09:49:34 INFO - 2015-11-24 09:49:34,559 DEBUG : BROWSER_OUTPUT: Values: 358.8 361.3 363.2 365.5 365.8 16200.5 16920.4 20035.6 20438.3 21133.4 20937.6 21030.5 22238.4 22331.3 22335.2 5694.2 6415.1 6606.2 6607.4 6607.8 4557.6 4632.1 6449.0 7137.3 7381.8 7236.3 7370.6 7441.4 7450.1 7459.7 7342.7 7395.6 7398.5 7406.0 7409.3 6905.6 7120.8 7141.2 7147.0 7152.1 20907.0 20939.6 25180.6 27406.8 28151.9 2272.0 2355.9 2445.3 2475.3 2576.8 15370.0 15903.5 15984.5 16079.3 16304.9 1815.9 1843.7 1867.7 1884.8 1886.4 117303.8 118063.8 118587.0 118867.8 122387.4 18707.6 19049.7 19141.5 19201.4 19203.9 28071.0 28150.9 28158.9 28174.9 28245.3 10313.2 10328.8 10365.8 10372.2 10420.2 7307.2 7580.9 8655.6 8750.9 8790.1 6677.4 8612.7 8623.7 8745.9 8762.5 1427.0 1568.2 1862.9 1863.9 1865.3 859.5 869.1 906.1 919.8 1011.2 16062.6 16841.8 20209.9 21058.1 21423.8 956.4 975.6 1000.3 1045.4 1064.6 11006.8 11111.7 11851.9 11854.2 11854.8 706811.0 734751.0 736173.0 742747.0 762992.0 112743.0 115094.0 115652.0 117101.0 119533.4 986.8 1213.0 1219.6 1224.7 1226.5 18257.4 18553.1 18980.6 19051.9 19422.5 47976.0 51025.2 51105.0 51182.0 51207.2 68129.3 68419.7 68432.6 69534.0 70308.6 8113.5 9914.5 9917.4 10061.3 10097.9 20107.0 20315.9 20404.9 20618.9 20676.4 15162.8 15522.6 15785.2 15956.0 16277.6 12576.6 12828.9 15094.4 15293.5 15398.5 15749.8 15804.8 16079.2 16100.5 16473.7 9421.7 9643.7 9719.5 9740.9 9742.7 10849.0 15150.1 15179.7 15488.8 15533.9 09:49:34 INFO - 2015-11-24 09:49:34,559 DEBUG : BROWSER_OUTPUT: 09:49:34 INFO - 2015-11-24 09:49:34,559 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5861.05 Median:5316.38 stddev:3075.35 (57.8%) stddev-sans-first:3067.15 09:49:34 INFO - 2015-11-24 09:49:34,560 DEBUG : BROWSER_OUTPUT: Values: 1581.1 1584.9 1705.5 1880.5 1889.0 6963.7 7629.2 8286.8 8647.4 8675.3 8351.7 8504.2 8562.9 8563.4 8575.7 2361.4 2380.7 2382.9 2383.3 2383.4 2378.2 2399.2 2419.4 2426.3 2427.9 2352.0 2376.9 2381.1 2381.5 2387.7 2333.6 2360.1 2370.1 2371.8 2384.4 2355.8 2377.2 2389.1 2389.5 2396.1 7688.9 8431.1 8462.2 8477.4 8485.6 4386.8 4777.5 4824.7 4846.2 5228.4 3478.8 3555.3 3589.1 3593.9 3624.6 1040.2 1060.7 1070.3 1071.5 1078.9 11222.2 11263.5 11277.1 11280.5 11289.3 4701.9 4710.6 4759.3 4775.6 4777.1 9819.9 9851.5 9856.5 9865.0 9865.9 5306.3 5311.9 5320.9 5323.8 5328.4 4123.9 4844.9 4848.9 4850.5 4852.3 3286.6 3669.6 3750.7 3755.8 3775.9 1227.1 1233.9 1235.6 1244.1 1245.7 1395.9 1411.3 1413.2 1428.8 1437.1 7935.8 7992.4 7995.9 8005.8 8023.0 427.5 432.6 507.1 507.3 517.4 5954.2 6097.1 6179.7 6202.5 6207.3 9023.3 10051.5 10302.2 10305.5 10387.1 10026.1 10122.1 10124.2 10223.3 10293.1 7900.9 7987.2 8065.8 8076.6 8103.3 7608.5 7739.8 7773.9 7783.6 7791.0 9015.0 9075.7 9162.9 9182.0 9295.5 9179.2 9442.4 9456.1 9569.0 9580.0 7059.3 7267.8 7340.3 7370.0 7388.3 7144.3 7866.9 7997.2 8091.8 8146.0 7451.5 7542.5 7575.2 7636.8 7694.3 7481.0 7483.2 7515.9 7606.9 7616.2 7616.4 7659.9 7665.7 7668.7 7677.8 5892.2 6941.1 6970.7 6981.0 6986.1 7026.8 7076.6 7083.7 7084.5 7087.9 09:49:34 INFO - 2015-11-24 09:49:34,560 DEBUG : BROWSER_OUTPUT: 09:49:34 INFO - 2015-11-24 09:49:34,560 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6015.72 Median:6851.88 stddev:1968.21 (28.7%) stddev-sans-first:1925.90 09:49:34 INFO - 2015-11-24 09:49:34,561 DEBUG : BROWSER_OUTPUT: Values: 269.9 330.9 334.4 334.4 335.6 6800.8 6912.6 6951.2 6974.5 7051.8 5500.8 6903.0 6948.7 6975.4 6998.0 5067.7 5110.6 5117.9 5120.4 5126.0 4107.5 4185.5 4804.1 4855.9 5116.5 4932.5 4937.6 5041.5 5044.9 5058.9 5000.5 5014.0 5025.1 5032.2 5045.1 4293.6 4296.2 4297.8 4305.1 4305.3 5929.4 6145.4 6359.3 6644.5 6664.1 5994.9 6011.1 6013.1 6013.2 6014.5 5958.9 7366.3 7374.9 7386.8 7387.3 4646.2 4872.2 4876.5 4884.1 4885.2 7883.3 7963.3 7964.0 7966.0 7970.0 4834.1 4842.9 4843.6 4845.4 4855.3 4715.6 4739.6 4781.9 4785.3 4945.2 5957.8 5963.6 5977.1 5980.4 5987.0 7509.2 7510.3 7525.7 7528.5 7534.4 1655.9 1685.3 1704.0 1710.2 1710.9 916.6 1065.7 1080.3 1084.2 1086.3 6942.7 6949.3 6952.1 6954.3 6979.4 6239.8 7713.2 7722.6 7732.9 7742.6 5754.5 6630.5 6916.5 6938.9 6955.6 4073.3 4115.0 4116.5 4120.8 4134.8 5871.0 7941.2 7958.9 7966.9 7976.4 5879.1 7973.0 8020.5 8145.6 8156.7 8133.7 8136.8 8141.0 8167.5 8177.6 6338.6 7634.7 7864.1 7874.4 7880.1 5529.1 6213.4 7437.6 7612.7 7696.2 8091.2 8093.1 8100.6 8116.8 8119.0 4645.7 4731.1 4740.8 4800.1 4849.9 7764.9 7767.5 7768.7 7786.3 7791.7 7476.0 7485.4 7488.0 7502.1 7506.6 7280.9 7483.3 7547.4 7549.3 7585.8 7176.9 7365.0 7368.3 7368.9 7373.5 6488.0 7290.8 7546.6 7557.6 7575.6 7356.9 7363.3 7366.1 7367.2 7379.0 09:49:34 INFO - 2015-11-24 09:49:34,562 DEBUG : BROWSER_OUTPUT: 09:49:34 INFO - 2015-11-24 09:49:34,562 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19402.56 Median:2307.72 stddev:27840.21 (1206.4%) stddev-sans-first:27882.97 09:49:34 INFO - 2015-11-24 09:49:34,563 DEBUG : BROWSER_OUTPUT: Values: 718.8 776.0 811.8 823.2 834.4 15068.7 15365.7 15376.9 15389.0 15405.5 14227.8 14363.2 14365.2 14385.9 14451.3 756.4 764.3 764.7 939.1 947.6 941.3 948.2 963.5 964.0 966.3 992.5 1010.1 1013.3 1013.9 1015.3 790.3 802.1 973.8 993.3 1009.2 744.3 751.1 753.4 754.3 754.3 14977.3 15180.3 15187.0 15206.3 15229.2 12664.9 12962.6 13116.3 13322.5 13445.8 10171.6 10342.6 10391.2 10521.5 10710.7 3483.9 3605.5 3644.4 3684.8 3747.8 74023.5 78878.0 80141.6 80430.6 80591.0 9213.2 9522.0 9776.4 9834.3 10143.5 20921.6 21158.9 21525.0 21860.1 21891.1 7122.0 7195.2 7204.9 7320.3 7323.3 3851.6 3864.7 3915.7 3918.0 3950.3 3519.1 3566.8 3567.9 3568.5 3574.8 631.5 633.6 633.8 654.3 660.1 478.6 495.7 505.7 520.8 602.0 8775.8 9370.6 9390.8 9401.2 9557.9 426.4 505.9 526.7 588.7 614.0 3927.5 4060.9 4069.6 4132.6 4189.0 100596.0 102363.5 102378.0 102478.5 103386.5 86857.0 87141.1 87695.6 88107.6 88733.6 67640.0 68491.0 74755.6 75404.6 75942.0 8406.8 8549.4 8732.6 9076.4 9147.2 52027.0 52585.0 52728.7 53929.1 54726.5 78180.6 78213.2 78225.6 78283.6 79765.6 11172.6 11275.8 11280.5 11411.7 11691.9 12029.9 12201.3 12333.1 12346.3 12457.9 11751.7 11773.0 11874.5 12037.4 12040.9 11689.8 11707.3 11955.6 11969.6 11975.3 11161.6 11275.9 11479.4 11736.4 12338.1 8296.5 9684.6 9729.6 10306.5 10475.8 9352.5 9550.3 10161.5 10173.2 10200.6 09:49:34 INFO - 2015-11-24 09:49:34,563 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:49:34 INFO - 2015-11-24 09:49:34,563 DEBUG : BROWSER_OUTPUT: 09:49:35 INFO - 2015-11-24 09:49:35,019 INFO : Browser exited with error code: 0 09:49:35 INFO - 2015-11-24 09:49:35,041 INFO : Completed test dromaeo_css (00:18:34) 09:49:35 INFO - 2015-11-24 09:49:35,041 INFO : Starting test kraken 09:49:35 INFO - 2015-11-24 09:49:35,041 DEBUG : operating with platform_type : mac_ 09:49:35 INFO - 2015-11-24 09:49:35,041 INFO : Initialising browser for kraken test... 09:49:35 INFO - 2015-11-24 09:49:35,051 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpBiHs4X/profile http://localhost:49272/getInfo.html 09:49:37 INFO - 2015-11-24 09:49:37,079 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:49:37 INFO - 2015-11-24 09:49:37,079 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:49:37 INFO - 2015-11-24 09:49:37,079 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:49:37 INFO - 2015-11-24 09:49:37,079 DEBUG : BROWSER_OUTPUT: __metrics 09:49:37 INFO - 2015-11-24 09:49:37,095 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:49:37 INFO - 2015-11-24 09:49:37,924 INFO : Browser initialized. 09:49:37 INFO - 2015-11-24 09:49:37,924 INFO : Running cycle 1/1 for kraken test... 09:49:37 INFO - 2015-11-24 09:49:37,924 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpBiHs4X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:49:49 INFO - 2015-11-24 09:49:49,783 DEBUG : BROWSER_OUTPUT: RSS: Main: 225169408 09:49:49 INFO - 2015-11-24 09:49:49,783 DEBUG : BROWSER_OUTPUT: 09:49:52 INFO - 2015-11-24 09:49:52,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 09:49:52 INFO - 2015-11-24 09:49:52,888 DEBUG : BROWSER_OUTPUT: RSS: Main: 276131840 09:49:52 INFO - 2015-11-24 09:49:52,888 DEBUG : BROWSER_OUTPUT: 09:49:55 INFO - 2015-11-24 09:49:55,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 09:49:56 INFO - 2015-11-24 09:49:56,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 291176448 09:49:56 INFO - 2015-11-24 09:49:56,121 DEBUG : BROWSER_OUTPUT: 09:49:59 INFO - 2015-11-24 09:49:59,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 09:49:59 INFO - 2015-11-24 09:49:59,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 278204416 09:49:59 INFO - 2015-11-24 09:49:59,916 DEBUG : BROWSER_OUTPUT: 09:50:01 INFO - 2015-11-24 09:50:01,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 09:50:02 INFO - 2015-11-24 09:50:02,362 DEBUG : BROWSER_OUTPUT: RSS: Main: 280244224 09:50:02 INFO - 2015-11-24 09:50:02,362 DEBUG : BROWSER_OUTPUT: 09:50:04 INFO - 2015-11-24 09:50:04,489 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:50:05 INFO - 2015-11-24 09:50:05,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 281124864 09:50:05 INFO - 2015-11-24 09:50:05,071 DEBUG : BROWSER_OUTPUT: 09:50:07 INFO - 2015-11-24 09:50:07,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 09:50:08 INFO - 2015-11-24 09:50:08,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 281124864 09:50:08 INFO - 2015-11-24 09:50:08,459 DEBUG : BROWSER_OUTPUT: 09:50:11 INFO - 2015-11-24 09:50:11,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 09:50:11 INFO - 2015-11-24 09:50:11,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 281124864 09:50:11 INFO - 2015-11-24 09:50:11,808 DEBUG : BROWSER_OUTPUT: 09:50:14 INFO - 2015-11-24 09:50:14,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 09:50:15 INFO - 2015-11-24 09:50:15,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 281317376 09:50:15 INFO - 2015-11-24 09:50:15,130 DEBUG : BROWSER_OUTPUT: 09:50:16 INFO - 2015-11-24 09:50:16,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:50:17 INFO - 2015-11-24 09:50:17,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 315445248 09:50:17 INFO - 2015-11-24 09:50:17,231 DEBUG : BROWSER_OUTPUT: 09:50:18 INFO - 2015-11-24 09:50:18,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:50:19 INFO - 2015-11-24 09:50:19,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 316497920 09:50:19 INFO - 2015-11-24 09:50:19,615 DEBUG : BROWSER_OUTPUT: 09:50:21 INFO - 2015-11-24 09:50:21,647 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:50:22 INFO - 2015-11-24 09:50:22,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 324317184 09:50:22 INFO - 2015-11-24 09:50:22,234 DEBUG : BROWSER_OUTPUT: 09:50:24 INFO - 2015-11-24 09:50:24,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:50:25 INFO - 2015-11-24 09:50:25,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 325967872 09:50:25 INFO - 2015-11-24 09:50:25,459 DEBUG : BROWSER_OUTPUT: 09:50:27 INFO - 2015-11-24 09:50:27,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:50:28 INFO - 2015-11-24 09:50:28,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 326471680 09:50:28 INFO - 2015-11-24 09:50:28,457 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,233 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 09:50:30 INFO - 2015-11-24 09:50:30,492 DEBUG : BROWSER_OUTPUT: RSS: Main: 385212416 09:50:30 INFO - 2015-11-24 09:50:30,492 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,492 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:50:30 INFO - 2015-11-24 09:50:30,492 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;104;110;110;110;110;110;102;111 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;115;142;173;146;167;138;117;153;119 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |2;audio-dft;185;181;180;219;183;182;185;184;180;181 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |3;audio-fft;61;72;77;72;55;62;57;72;73;58 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;82;87;113;75;74;75;113;104;109;139 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;88;88;87;88;132;127;87;87;88;87 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;93;94;94;94;94;94;94;94;94;94 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;125;92;84;84;96;86;85;84;84;84 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;56;55;56;53;54;55;54;64;53;54 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;65;65;67;67;67;72;69 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;83;83;83;80;82;82;83;82 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;149;143;122;122;119;105;129;137;142 09:50:30 INFO - 2015-11-24 09:50:30,493 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;121;137;135;137;125;141;138;139;139 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;59;85;55;73;94;91;90;70;64;65 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1018 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: __startTimestamp1448387430487__endTimestamp 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:3.03 (2.8%) stddev-sans-first:3.21 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 104.0 110.0 110.0 110.0 110.0 110.0 102.0 111.0 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,494 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.00 Median:149.50 stddev:20.91 (14.0%) stddev-sans-first:21.26 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: Values: 160.0 115.0 142.0 173.0 146.0 167.0 138.0 117.0 153.0 119.0 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:186.00 Median:183.50 stddev:11.75 (6.4%) stddev-sans-first:12.45 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: Values: 185.0 181.0 180.0 219.0 183.0 182.0 185.0 184.0 180.0 181.0 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:65.90 Median:72.00 stddev:8.06 (11.2%) stddev-sans-first:8.35 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: Values: 61.0 72.0 77.0 72.0 55.0 62.0 57.0 72.0 73.0 58.0 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:97.10 Median:74.50 stddev:21.83 (29.3%) stddev-sans-first:22.47 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: Values: 82.0 87.0 113.0 75.0 74.0 75.0 113.0 104.0 109.0 139.0 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:95.90 Median:87.50 stddev:17.75 (20.3%) stddev-sans-first:18.60 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: Values: 88.0 88.0 87.0 88.0 132.0 127.0 87.0 87.0 88.0 87.0 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,495 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:90.40 Median:84.50 stddev:12.84 (15.2%) stddev-sans-first:4.39 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: Values: 125.0 92.0 84.0 84.0 96.0 86.0 85.0 84.0 84.0 84.0 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:3.20 (5.8%) stddev-sans-first:3.39 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: Values: 56.0 55.0 56.0 53.0 54.0 55.0 54.0 64.0 53.0 54.0 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:67.00 stddev:2.71 (4.0%) stddev-sans-first:2.60 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 65.0 65.0 67.0 67.0 67.0 72.0 69.0 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:0.92 (1.1%) stddev-sans-first:0.97 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 83.0 83.0 83.0 80.0 82.0 82.0 83.0 82.0 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,496 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.70 Median:133.00 stddev:13.33 (10.0%) stddev-sans-first:14.13 09:50:30 INFO - 2015-11-24 09:50:30,497 DEBUG : BROWSER_OUTPUT: Values: 129.0 149.0 143.0 122.0 122.0 119.0 105.0 129.0 137.0 142.0 09:50:30 INFO - 2015-11-24 09:50:30,497 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,497 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.30 Median:138.50 stddev:6.80 (4.9%) stddev-sans-first:6.89 09:50:30 INFO - 2015-11-24 09:50:30,497 DEBUG : BROWSER_OUTPUT: Values: 141.0 121.0 137.0 135.0 137.0 125.0 141.0 138.0 139.0 139.0 09:50:30 INFO - 2015-11-24 09:50:30,497 DEBUG : BROWSER_OUTPUT: 09:50:30 INFO - 2015-11-24 09:50:30,497 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:79.00 stddev:14.32 (18.1%) stddev-sans-first:14.04 09:50:30 INFO - 2015-11-24 09:50:30,497 DEBUG : BROWSER_OUTPUT: Values: 59.0 85.0 55.0 73.0 94.0 91.0 90.0 70.0 64.0 65.0 09:50:30 INFO - 2015-11-24 09:50:30,497 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:50:30 INFO - 2015-11-24 09:50:30,497 DEBUG : BROWSER_OUTPUT: 09:50:31 INFO - 2015-11-24 09:50:31,093 INFO : Browser exited with error code: 0 09:50:31 INFO - 2015-11-24 09:50:31,137 INFO : Completed test kraken (00:00:56) 09:50:31 INFO - 2015-11-24 09:50:31,137 INFO : Starting test v8_7 09:50:31 INFO - 2015-11-24 09:50:31,137 DEBUG : operating with platform_type : mac_ 09:50:31 INFO - 2015-11-24 09:50:31,137 INFO : Initialising browser for v8_7 test... 09:50:31 INFO - 2015-11-24 09:50:31,150 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpdd_a2k/profile http://localhost:49272/getInfo.html 09:50:33 INFO - 2015-11-24 09:50:33,258 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:50:33 INFO - 2015-11-24 09:50:33,259 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:50:33 INFO - 2015-11-24 09:50:33,259 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 09:50:33 INFO - 2015-11-24 09:50:33,259 DEBUG : BROWSER_OUTPUT: __metrics 09:50:33 INFO - 2015-11-24 09:50:33,277 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:50:33 INFO - 2015-11-24 09:50:33,955 INFO : Browser initialized. 09:50:33 INFO - 2015-11-24 09:50:33,955 INFO : Running cycle 1/1 for v8_7 test... 09:50:33 INFO - 2015-11-24 09:50:33,956 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/tmpdd_a2k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:50:45 INFO - 2015-11-24 09:50:45,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 226070528 09:50:45 INFO - 2015-11-24 09:50:45,732 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49272/tests/v8_7/run.html (next: http://localhost:49272/tests/v8_7/run.html) 09:51:07 INFO - 2015-11-24 09:51:07,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 616050688 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: |0;Richards;177.33640716439086 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;205.1702913418137 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: |2;Encrypt;284.4141069397042 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4799.043062200957 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1727.1157167530225 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: |5;Earley;997.0089730807578 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: |6;Boyer;13328.947368421053 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: |7;RegExp;28388.88888888889 09:51:07 INFO - 2015-11-24 09:51:07,380 DEBUG : BROWSER_OUTPUT: |8;Splay;650.6180871828237 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4868.9320388349515 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: __startTimestamp1448387467373__endTimestamp 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:177.34 Median:177.34 stddev:0.00 (0.0%) 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: Values: 177.3 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:205.17 Median:205.17 stddev:0.00 (0.0%) 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: Values: 205.2 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,381 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:284.41 Median:284.41 stddev:0.00 (0.0%) 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: Values: 284.4 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4799.04 Median:4799.04 stddev:0.00 (0.0%) 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: Values: 4799.0 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1727.12 Median:1727.12 stddev:0.00 (0.0%) 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: Values: 1727.1 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:997.01 Median:997.01 stddev:0.00 (0.0%) 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: Values: 997.0 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13328.95 Median:13328.95 stddev:0.00 (0.0%) 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: Values: 13328.9 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,382 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28388.89 Median:28388.89 stddev:0.00 (0.0%) 09:51:07 INFO - 2015-11-24 09:51:07,383 DEBUG : BROWSER_OUTPUT: Values: 28388.9 09:51:07 INFO - 2015-11-24 09:51:07,383 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,383 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:650.62 Median:650.62 stddev:0.00 (0.0%) 09:51:07 INFO - 2015-11-24 09:51:07,383 DEBUG : BROWSER_OUTPUT: Values: 650.6 09:51:07 INFO - 2015-11-24 09:51:07,383 DEBUG : BROWSER_OUTPUT: 09:51:07 INFO - 2015-11-24 09:51:07,383 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 09:51:07 INFO - 2015-11-24 09:51:07,383 DEBUG : BROWSER_OUTPUT: Values: 4868.9 09:51:07 INFO - 2015-11-24 09:51:07,383 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:51:07 INFO - 2015-11-24 09:51:07,383 DEBUG : BROWSER_OUTPUT: 09:51:08 INFO - 2015-11-24 09:51:08,000 INFO : Browser exited with error code: 0 09:51:08 INFO - 2015-11-24 09:51:08,018 INFO : Completed test v8_7 (00:00:36) 09:51:08 INFO - 2015-11-24 09:51:08,038 INFO : Completed test suite (00:20:07) 09:51:08 INFO - 2015-11-24 09:51:08,038 DEBUG : Working with test: dromaeo_css 09:51:08 INFO - 2015-11-24 09:51:08,038 DEBUG : Generating results file: dromaeo_css 09:51:08 INFO - 2015-11-24 09:51:08,039 DEBUG : Working with test: kraken 09:51:08 INFO - 2015-11-24 09:51:08,039 DEBUG : Generating results file: kraken 09:51:08 INFO - 2015-11-24 09:51:08,039 INFO : javascript benchmark 09:51:08 INFO - 2015-11-24 09:51:08,040 DEBUG : Working with test: v8_7 09:51:08 INFO - 2015-11-24 09:51:08,040 DEBUG : Generating results file: v8_7 09:51:08 INFO - 2015-11-24 09:51:08,040 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:08 INFO - 2015-11-24 09:51:08,544 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 09:51:08 INFO - 2015-11-24 09:51:08,544 DEBUG : process_Request line: dromaeo_css 7894.37 graph.html#tests=[[72,64,59]] 09:51:08 INFO - 2015-11-24 09:51:08,544 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:08 INFO - 2015-11-24 09:51:08,573 DEBUG : process_Request line: kraken 1424.30 graph.html#tests=[[232,64,59]] 09:51:08 INFO - 2015-11-24 09:51:08,573 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:51:08 INFO - 2015-11-24 09:51:08,609 DEBUG : process_Request line: v8_7 18984.35 graph.html#tests=[[230,64,59]] 09:51:08 INFO - 2015-11-24 09:51:08,610 INFO : javascript benchmark 09:51:08 INFO - 2015-11-24 09:51:08,611 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3443.466262729277, 3479.095435186851, 3522.8766993155227, 3533.4699795030742, 3563.8396272167756, 5435.592330575213, 5840.824775256739, 5950.226470558827, 5966.224390829191, 6016.699165041747, 5873.471387575118, 5874.383189765077, 5894.734736936837, 5914.970425147879, 6046.365131661179, 5243.528082472577, 5261.710605916673, 5291.391489978663, 5330.680159190461, 5407.3781515125675, 5376.032314183445, 5401.4868587484125, 5420.647657902244, 5443.374011988612, 5449.482299181572, 5152.07262692717, 5256.81601143962, 5277.076511610453, 5281.234221037928, 5407.432219616942, 5177.145770947826, 5307.522322990911, 5314.973425132888, 5315.6013299002725, 5332.466753324676, 5251.76367063483, 5309.814156504543, 5324.201369794523, 5331.760070796823, 5341.893162136736, 5879.7648094076185, 5893.14549390336, 5917.171595976567, 5926.703664816742, 5945.078512830518, 6201.7519299228425, 6204.596701214452, 6300.873982520324, 6317.905231421532, 6336.651484168369, 6369.777057803001, 6377.904331435032, 6381.425671689523, 6390.265119511269, 6394.968025159891, 5088.414832294259, 6053.303870054912, 6134.263888333384, 6137.324894261627, 6163.845903852395, 6199.504039676815, 6301.936980630227, 6367.777127800505, 6368.10846481493, 6408.61548307103, 6311.652859092794, 6370.0763389308295, 6376.553641245068, 6381.0, 6397.040443933447, 6348.365163483615, 6348.714307856158, 6362.459190968727, 6365.936340636535, 6372.872542549123, 6197.070439434121, 6204.7828326008375, 6296.5592408531875, 6334.873302533923, 6348.587341822767, 6320.683965801783, 6335.0, 6335.11308416822, 6337.841553961096, 6355.0785136155, 5042.445331013586, 5085.593152547787, 5109.642325037212, 5111.846644600668, 5158.329417175818, 3788.7158463115375, 4446.466424029137, 4487.685861989695, 4559.088182363541, 4583.702059366197, 5907.527397808165, 5925.111233315038, 5945.3757355477055, 5950.940490595125, 5952.226210592682, 6376.649284289409, 6381.744730210832, 6387.520935929824, 6389.552731308764, 6403.391677790602, 5654.6324488908085, 5725.742341594639, 5801.767929282782, 5821.476067153976, 5877.089051197071, 5545.556355491632, 5571.4150014248735, 5573.916391254134, 5592.189132575753, 5598.300212473441, 6439.195100612424, 6451.967740161269, 6523.64119973406, 6547.312532184147, 6552.213734351908, 6172.105044768394, 6202.28673702512, 6288.930881750022, 6289.276733175743, 6313.589616674902, 6346.365363463617, 6349.984002559569, 6363.5863668861375, 6374.394432528902, 6435.356464353715, 5219.4780521947505, 6267.592606480564, 6269.749210031548, 6275.5920865145445, 6309.779157729457, 6156.507479401726, 6232.626042437469, 6270.968645156928, 6304.6847657617855, 6363.077353783768, 6291.811245662638, 6312.58968167086, 6338.080978258219, 6351.618902865843, 6352.142460767737, 6319.6208227506495, 6333.334999824952, 6338.302786693553, 6349.49204063683, 6354.93645063562, 5908.645481271137, 6052.251739310725, 6091.086337049478, 6170.074488826712, 6198.442140207403, 6141.117811340085, 6217.285012223652, 6251.249850018027, 6258.217722784652, 6296.024116261987, 6024.939750602438, 6226.346233645402, 6243.250809902841, 6256.31180570146, 6265.937340626718], "unit": "ms", "name": "dojo.html", "value": 5832.030427631737}, {"lowerIsBetter": false, "replicates": [543.1716632135995, 549.4121290219464, 576.4149388370807, 598.2014011294921, 621.7140115546848, 32648.347033059326, 33131.006069817915, 42263.78868105663, 42688.0, 42791.57208427915, 44521.88695282619, 44856.87857803557, 44924.55075449245, 45071.0, 45358.0928381433, 9778.559964801583, 9942.652007179713, 9971.40457526796, 9977.850332244985, 9988.700338989842, 8814.427062240966, 8915.643374265053, 8919.910800892005, 11938.641840744747, 12064.457099430503, 11830.290182589073, 11900.166988310822, 11907.464164112593, 11919.344436056013, 11920.523179072827, 8876.911230887737, 11773.7645247095, 11896.821547676791, 11897.226680265756, 11997.160198786089, 8686.174813392718, 8796.56017199144, 8811.559422028873, 8824.69113581028, 11785.941070294679, 41447.0, 41898.53355132586, 41901.60033196532, 41926.371104433456, 41970.790146049076, 3201.103690966533, 3250.236194494292, 3293.5389045533643, 3418.3334249821296, 3490.0925759302763, 28881.0, 29552.852235738683, 30033.69966300331, 30306.0, 30583.694163058306, 2833.3483298841384, 2896.8551572421293, 2897.1163795042503, 2927.809692369989, 3039.5136778115616, 510285.0, 514941.0, 515146.42426788004, 515726.0, 517084.0, 72491.0, 72816.27183728201, 72819.63590182015, 72847.0, 73011.2698873015, 76753.0, 77042.84435733469, 77273.61363193148, 77309.0, 77415.0, 15239.314230859638, 16858.494245172664, 17005.659886802194, 17048.062356570506, 17049.7442538362, 11282.774344513064, 11323.980841724284, 11324.32054076758, 11334.60328888485, 11339.603113891138, 17717.7342339865, 18377.67182930378, 22524.54950900973, 23240.883795580914, 23505.29484115479, 7942.483738556975, 9793.510324483746, 9794.510274486247, 9798.216142708567, 9842.950785246028, 745.9254074592606, 902.1384577728254, 983.4541829284816, 985.3299756165733, 1057.799018186542, 22307.88846055792, 29171.0, 29653.258668533028, 29790.615955973797, 30330.0, 1033.6588925654517, 1085.9511321990528, 1100.763335882789, 1109.2197023776882, 1158.212415557429, 15323.770143447857, 15536.689266214613, 15609.453669121527, 15654.433257551107, 15875.444359447363, 676877.0, 680573.0, 681138.0, 682886.0, 684882.0, 55501.0, 63984.0, 64074.35925640777, 64180.03729944055, 64185.35814641794, 1309.6202101390681, 1332.027619837524, 1454.3382760844001, 1539.8075240594926, 1584.3741722019738, 30656.540151898185, 30802.0, 30802.0, 31141.688583114785, 31362.21594460157, 50475.0, 51846.48153518417, 52298.0, 52466.0, 52485.95028099493, 375363.0, 672785.0, 675127.0, 675298.0, 676854.0, 33792.3241535163, 34430.87298613713, 34677.91932484059, 34758.30483390267, 34833.65166348304, 45822.0, 46414.07171856611, 46872.7656361716, 47783.52216477791, 47854.28218576794, 34821.477677834344, 36970.8151459241, 38029.0, 39016.80491597524, 39090.609093909836, 37444.81277593595, 37599.624003759614, 38387.80806096063, 38567.614323857524, 38657.0, 37602.43596346112, 38469.6153038466, 38637.420438694004, 38639.0, 38669.41995870008, 33290.00129996104, 33780.66219337775, 34202.82898585491, 34439.82780086083, 34741.65258347485, 23991.880040599684, 24913.0, 25157.748422516273, 25361.365965850262, 25394.0], "unit": "ms", "name": "ext.html", "value": 20925.64856525568}, {"lowerIsBetter": false, "replicates": [358.7919006975953, 361.2540104683828, 363.2227034146928, 365.48466662006575, 365.7659098177167, 16200.513984580452, 16920.4077857275, 20035.59928801423, 20438.2846600369, 21133.365999020014, 20937.581248375023, 21030.474238144056, 22238.444038898997, 22331.330060098182, 22335.218267360644, 5694.202811606378, 6415.06981487684, 6606.207255129391, 6607.438367738748, 6607.834804129911, 4557.589816916477, 4632.14305353509, 6448.967755161218, 7137.286271372847, 7381.778546643583, 7236.312550307739, 7370.631468426584, 7441.367483763886, 7450.143233528132, 7459.664315105806, 7342.706291748324, 7395.556266623993, 7398.519096258726, 7405.962970185168, 7409.296116868889, 6905.585664860125, 7120.789465790828, 7141.214466408691, 7146.964265178641, 7152.141742990822, 20906.95465226748, 20939.5812083759, 25180.622290665655, 27406.76669549875, 28151.873925042975, 2271.9772802272096, 2355.8586484810794, 2445.339758265276, 2475.282168171228, 2576.780973617245, 15370.00094993833, 15903.52289431319, 15984.520464386087, 16079.276432560562, 16304.918475407665, 1815.8728888977778, 1843.732658764485, 1867.7478540397144, 1884.8303652671189, 1886.368066697658, 117303.82696173014, 118063.81936180615, 118587.0, 118867.81132188653, 122387.38806306, 18707.625847483247, 19049.71425428592, 19141.521461963563, 19201.423957281302, 19203.90398048001, 28071.0, 28150.85924570364, 28158.85920570384, 28174.87300507998, 28245.293867653472, 10313.226508011929, 10328.793424131476, 10365.844512332322, 10372.222083343779, 10420.218483613759, 7307.232740562271, 7580.886286705704, 8655.610497527627, 8750.912490875136, 8790.120987901159, 6677.383904162473, 8612.698555550525, 8623.655053797778, 8745.868811967826, 8762.474251544927, 1426.9500567480088, 1568.192380923825, 1862.850971922243, 1863.8881667100018, 1865.291189348039, 859.4542465534431, 869.1265278395173, 906.1165363770403, 919.8252332057021, 1011.2365164300905, 16062.598435039217, 16841.831581684026, 20209.94624058466, 21058.052387642594, 21423.785762142492, 956.4022485946283, 975.6097560975667, 1000.3197825478744, 1045.362328979322, 1064.6380230721593, 11006.779864402668, 11111.666650000512, 11851.88148118525, 11854.229475084092, 11854.762904742029, 706811.0, 734751.0, 736173.0, 742747.0, 762992.0, 112743.0, 115094.0, 115652.0, 117101.0, 119533.40233298778, 986.7582442301682, 1212.9818052729215, 1219.6463025722442, 1224.6632176151809, 1226.533917111492, 18257.360992365204, 18553.072346382898, 18980.57645676552, 19051.904740476763, 19422.514437139183, 47976.04047919092, 51025.23462147996, 51105.0, 51182.0, 51207.2318915224, 68129.3187068123, 68419.65790171217, 68432.63134737377, 69534.0, 70308.6484567574, 8113.472624279403, 9914.454704991294, 9917.355371900803, 10061.295709300279, 10097.899021009696, 20107.0, 20315.8984205078, 20404.877731724304, 20618.865962372212, 20676.379708608765, 15162.772558411412, 15522.611934701723, 15785.210739462751, 15956.042637441791, 16277.593060173116, 12576.559820406243, 12828.935855320664, 15094.39622415135, 15293.464728734441, 15398.46105386306, 15749.763753543477, 15804.841951580336, 16079.196040198178, 16100.516984490485, 16473.67052658964, 9421.670241541513, 9643.710688679352, 9719.514024298898, 9740.853887191555, 9742.659006934724, 10849.026095176749, 15150.090994540364, 15179.696406071596, 15488.767668484756, 15533.922330388275], "unit": "ms", "name": "jquery.html", "value": 11082.013889407617}, {"lowerIsBetter": false, "replicates": [1581.1303782919392, 1584.8652864506516, 1705.5139285303692, 1880.4640677406942, 1888.9905550472245, 6963.686634101465, 7629.1989341119215, 8286.792830179249, 8647.394682372236, 8675.349348798849, 8351.707690230844, 8504.19210175034, 8562.91437085629, 8563.443376180543, 8575.699850505234, 2361.445060410802, 2380.678608387863, 2382.8927698253533, 2383.3088404362716, 2383.4041489627593, 2378.203301893868, 2399.244238065004, 2419.4314336130997, 2426.3327584914114, 2427.8543287402813, 2351.95296094078, 2376.8811559422047, 2381.095183830142, 2381.499885024147, 2387.689600351952, 2333.603287441122, 2360.126753101355, 2370.051979208322, 2371.762823717623, 2384.3681424422543, 2355.8468699534474, 2377.2036367816804, 2389.0921449848947, 2389.4862604539935, 2396.065534441569, 7688.923110768933, 8431.072582016035, 8462.2383985441, 8477.448965817202, 8485.618147183392, 4386.793631751262, 4777.474477807438, 4824.734639594821, 4846.224604063368, 5228.398734145546, 3478.843452044664, 3555.253396786678, 3589.10272431892, 3593.94609080864, 3624.6012938576737, 1040.238167664851, 1060.7295139739394, 1070.3203465799195, 1071.539238127605, 1078.9298695584762, 11222.214444988855, 11263.493142808593, 11277.097832173406, 11280.548778048867, 11289.266197697123, 4701.858944231679, 4710.552497512731, 4759.286107083965, 4775.617950563947, 4777.092352453023, 9819.852702209473, 9851.50742462874, 9856.457894815854, 9864.950675246579, 9865.901340986642, 5306.328506520434, 5311.893762124736, 5320.866978325573, 5323.813666521653, 5328.387235467971, 4123.9381409278885, 4844.878878028007, 4848.8787780305065, 4850.466448690641, 4852.296417019513, 3286.622038465607, 3669.5963444021136, 3750.7374483785875, 3755.7746535207975, 3775.905602359963, 1227.098082909061, 1233.8889499945049, 1235.5552001279532, 1244.0980289290374, 1245.7383949370553, 1395.9371828267751, 1411.2731943049337, 1413.2107495064201, 1428.757111291083, 1437.1377173695698, 7935.769955656767, 7992.440529163019, 7995.920040799634, 8005.759827205193, 8023.0, 427.50196021634446, 432.60416718702663, 507.0821812519352, 507.32272416323883, 517.4230732732975, 5954.225950626391, 6097.054956481752, 6179.721912513947, 6202.534809889276, 6207.348228435949, 9023.323250756088, 10051.547680354402, 10302.175825933908, 10305.536250868729, 10387.117095046855, 10026.147777438853, 10122.139618132394, 10124.240681948737, 10223.335483193569, 10293.073623373932, 7900.933373994552, 7987.201279871966, 8065.83868322642, 8076.636551355321, 8103.31121854649, 7608.467407281437, 7739.845203095794, 7773.92226077732, 7783.571903545133, 7790.987171667874, 9014.954925225333, 9075.682351117679, 9162.862557061782, 9181.954090229507, 9295.535223238676, 9179.17387435134, 9442.433453992782, 9456.05439456049, 9568.95215523918, 9580.041995800364, 7059.294070593105, 7267.818304542428, 7340.265973402617, 7370.0, 7388.261173882784, 7144.285571442814, 7866.8593054008, 7997.200279971957, 8091.757247282591, 8145.959270203611, 7451.478396512409, 7542.547447153188, 7575.181956330552, 7636.8472630548185, 7694.269044440769, 7481.0, 7483.176850546544, 7515.887261690969, 7606.885896711665, 7616.162222155669, 7616.428767842323, 7659.88510172359, 7665.731699390718, 7668.731594394392, 7677.846443071219, 5892.234009578728, 6941.0629565010095, 6970.65146742671, 6980.965095174694, 6986.091808065123, 7026.754063607749, 7076.575405475688, 7083.68123434457, 7084.504084714021, 7087.893681594677], "unit": "ms", "name": "mootools.html", "value": 4716.57801485658}, {"lowerIsBetter": false, "replicates": [269.9149767823136, 330.91561651778795, 334.36213991769546, 334.44816053511687, 335.5604158552297, 6800.761973330935, 6912.619805910673, 6951.200611929629, 6974.546654467463, 7051.753188638399, 5500.752466139023, 6903.0, 6948.6873090710915, 6975.441964642829, 6998.0, 5067.746612669361, 5110.620132564205, 5117.948820511803, 5120.3855537335385, 5125.974370128163, 4107.54816970133, 4185.476815398075, 4804.063207674505, 4855.902881942359, 5116.539511443969, 4932.53140951609, 4937.580305674022, 5041.495850414965, 5044.924326135111, 5058.924116138261, 5000.524950129732, 5014.0, 5025.070361983045, 5032.169692000815, 5045.117104506697, 4293.592108749664, 4296.226679197744, 4297.828086876521, 4305.138972205571, 4305.289627211507, 5929.377415371367, 6145.385461453863, 6359.282993591704, 6644.534882558223, 6664.100346453215, 5994.8501287467725, 6011.098335249704, 6013.098035294697, 6013.1581578579035, 6014.51883849291, 5958.851028724273, 7366.337029667302, 7374.926250737478, 7386.815329616803, 7387.298206670358, 4646.210144275481, 4872.171730805771, 4876.512348765131, 4884.120858245515, 4885.218365061573, 7883.290503854623, 7963.3231175350165, 7964.0, 7965.960170199112, 7970.0, 4834.057358814997, 4842.927356089662, 4843.6367272454, 4845.418549773979, 4855.271709243641, 4715.622750180046, 4739.620830333565, 4781.928271075936, 4785.282207668808, 4945.23348880924, 5957.821265362046, 5963.612365196248, 5977.117208079441, 5980.372060933626, 5986.99435689049, 7509.173990861001, 7510.324070833542, 7525.736599219001, 7528.51064680794, 7534.397248220239, 1655.8840881138447, 1685.2500637216567, 1703.9829601704073, 1710.1791140252749, 1710.880238383326, 916.5646317998898, 1065.7122576904192, 1080.2924084724518, 1084.2301965604352, 1086.2884810449168, 6942.7222911084, 6949.339812717783, 6952.130983627047, 6954.3393377629045, 6979.406750426169, 6239.844003899848, 7713.190115037953, 7722.575258360844, 7732.922670773332, 7742.574158421341, 5754.539636829044, 6630.5027122965, 6916.515843890879, 6938.8612227756175, 6955.582665040114, 4073.327900896319, 4114.958850411457, 4116.464859568297, 4120.75275483472, 4134.813933373005, 5871.0, 7941.166177551274, 7958.880616790637, 7966.920330796734, 7976.401769867283, 5879.089850524018, 7972.960135199403, 8020.478668886503, 8145.551994640233, 8156.67373305073, 8133.674653013932, 8136.75589732309, 8140.959295203605, 8167.469114507538, 8177.632006559719, 6338.58799178052, 7634.732784352521, 7864.134945156143, 7874.409419293462, 7880.093789214314, 5529.142982837667, 6213.409726076015, 7437.628118594157, 7612.657430415756, 7696.230376962259, 8091.190880911861, 8093.109757926741, 8100.635471403919, 8116.75649730509, 8119.0, 4645.74448405341, 4731.077439899186, 4740.810367585258, 4800.0639875224, 4849.878753031202, 7764.9223507766455, 7767.53394796314, 7768.728094516665, 7786.26030527099, 7791.688332466638, 7475.962620186864, 7485.4385921055045, 7487.951686763967, 7502.099748030053, 7506.58713770726, 7280.854382912206, 7483.289087536676, 7547.358474529727, 7549.282818132268, 7585.810354740955, 7176.928230717626, 7365.0, 7368.263173682589, 7368.852622947404, 7373.520721153108, 6488.0, 7290.781276561712, 7546.584937828472, 7557.584332861746, 7575.583342916192, 7356.889646655198, 7363.263673632594, 7366.116066072105, 7367.189609143097, 7379.040724705754], "unit": "ms", "name": "prototype.html", "value": 5349.600614555003}, {"lowerIsBetter": false, "replicates": [718.8310746974461, 775.9728409505667, 811.7686459359084, 823.2220551578757, 834.370050611788, 15068.698626027473, 15365.692686146283, 15376.923115384407, 15388.99971501853, 15405.460808871692, 14227.78658320126, 14363.210023448706, 14365.209913454783, 14385.92807035966, 14451.349689263981, 756.440234226671, 764.2853931573968, 764.6979443119965, 939.1313035442223, 947.5783276441986, 941.3316545252878, 948.2177203806853, 963.4604621411996, 963.9614415423374, 966.3042609321277, 992.4591097851688, 1010.1312870930993, 1013.3413281367134, 1013.9036791504832, 1015.3349556040769, 790.3124281874748, 802.0655935834745, 973.8295798235351, 993.2500961773886, 1009.1724785675749, 744.2854859335044, 751.1211882097904, 753.4198667026359, 754.2570567990525, 754.2608243920934, 14977.251137443085, 15180.316885740169, 15187.0, 15206.315715792816, 15229.238538073163, 12664.873351266462, 12962.611121666365, 13116.344182790917, 13322.467101315935, 13445.798313025312, 10171.64399246023, 10342.586296548128, 10391.220658450646, 10521.473926303654, 10710.732231694192, 3483.8780642677384, 3605.5312809334882, 3644.3804553226014, 3684.778913265213, 3747.7938713370754, 74023.51952960965, 78878.0, 80141.59929200375, 80430.59784701097, 80591.0, 9213.216876565433, 9521.952390238004, 9776.364536305118, 9834.311598188202, 10143.543540540693, 20921.581568368547, 21158.894205528875, 21525.0, 21860.125594976023, 21891.12435502594, 7122.03852479919, 7195.172555156224, 7204.855902881913, 7320.267973202744, 7323.304286092813, 3851.5763266040713, 3864.729468937204, 3915.7454765440157, 3917.9804100979313, 3950.2889479893897, 3519.102628829632, 3566.7859928404378, 3567.8929632111076, 3568.518250036264, 3574.767640103385, 631.4601016131141, 633.6261605652687, 633.8415396150963, 654.2737561306946, 660.0528241972785, 478.62395612613733, 495.7248726956574, 505.69152816781735, 520.8229401552519, 601.9879602408015, 8775.824483510294, 9370.625174992923, 9390.812183756287, 9401.153896149379, 9557.856632150524, 426.43497365990186, 505.91146549353715, 526.6734624532737, 588.7291845750917, 613.96009259398, 3927.4501569780255, 4060.898477538085, 4069.593040695907, 4132.586741325843, 4189.0, 100596.0, 102363.4881825586, 102378.0, 102478.48760756297, 103386.48306758418, 86857.0, 87141.12858871456, 87695.56152219199, 88107.55946220228, 88733.55633221792, 67640.0, 68491.0, 74755.62622186964, 75404.62297688477, 75942.0, 8406.789830254293, 8549.358798090043, 8732.607032683418, 9076.41003334781, 9147.22248608849, 52026.99999999849, 52585.0, 52728.73635631951, 53929.11248106298, 54726.45273547373, 78180.60909695415, 78213.2178678206, 78225.60887195528, 78283.60858195672, 79765.60117199377, 11172.55309787632, 11275.801766701683, 11280.548778049115, 11411.714707132056, 11691.878980891855, 12029.879701202875, 12201.267923924594, 12333.136680432643, 12346.259224446561, 12457.935785264472, 11751.70841685863, 11773.0, 11874.525018999144, 12037.398130093636, 12040.879591203975, 11689.766204676029, 11707.2975621463, 11955.55953411132, 11969.64091077269, 11975.341356225492, 11161.55353785872, 11275.943620282174, 11479.417131145425, 11736.354500502553, 12338.136330456782, 8296.543690097102, 9684.612615495302, 9729.557842226319, 10306.484675766033, 10475.842862357224, 9352.485613291063, 9550.331476796557, 10161.542730576994, 10173.237007224636, 10200.591976320864], "unit": "ms", "name": "yui.html", "value": 7092.503140647662}], "name": "dromaeo_css", "value": 7894.367784933436}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 110.0, 110.0, 110.0, 110.0, 110.0, 102.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [160.0, 115.0, 142.0, 173.0, 146.0, 167.0, 138.0, 117.0, 153.0, 119.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [185.0, 181.0, 180.0, 219.0, 183.0, 182.0, 185.0, 184.0, 180.0, 181.0], "unit": "ms", "name": "audio-dft", "value": 186.0}, {"lowerIsBetter": true, "replicates": [61.0, 72.0, 77.0, 72.0, 55.0, 62.0, 57.0, 72.0, 73.0, 58.0], "unit": "ms", "name": "audio-fft", "value": 65.9}, {"lowerIsBetter": true, "replicates": [82.0, 87.0, 113.0, 75.0, 74.0, 75.0, 113.0, 104.0, 109.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 97.1}, {"lowerIsBetter": true, "replicates": [88.0, 88.0, 87.0, 88.0, 132.0, 127.0, 87.0, 87.0, 88.0, 87.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 95.9}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 93.9}, {"lowerIsBetter": true, "replicates": [125.0, 92.0, 84.0, 84.0, 96.0, 86.0, 85.0, 84.0, 84.0, 84.0], "unit": "ms", "name": "imaging-desaturate", "value": 90.4}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 53.0, 54.0, 55.0, 54.0, 64.0, 53.0, 54.0], "unit": "ms", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 65.0, 65.0, 67.0, 67.0, 67.0, 72.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.3}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 83.0, 83.0, 80.0, 82.0, 82.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [129.0, 149.0, 143.0, 122.0, 122.0, 119.0, 105.0, 129.0, 137.0, 142.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.7}, {"lowerIsBetter": true, "replicates": [141.0, 121.0, 137.0, 135.0, 137.0, 125.0, 141.0, 138.0, 139.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 135.3}, {"lowerIsBetter": true, "replicates": [59.0, 85.0, 55.0, 73.0, 94.0, 91.0, 90.0, 70.0, 64.0, 65.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 74.6}], "name": "kraken", "value": 1424.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [177.33640716439086], "unit": "score", "name": "Richards", "value": 199.06797799999995}, {"lowerIsBetter": false, "replicates": [205.1702913418137], "unit": "score", "name": "DeltaBlue", "value": 322.259132}, {"lowerIsBetter": false, "replicates": [284.4141069397042], "unit": "score", "name": "Encrypt", "value": 935.8923959999998}, {"lowerIsBetter": false, "replicates": [4799.043062200957], "unit": "score", "name": "Decrypt", "value": 55.4654327018943}, {"lowerIsBetter": false, "replicates": [1727.1157167530225], "unit": "score", "name": "RayTrace", "value": 428.4536310000001}, {"lowerIsBetter": false, "replicates": [997.0089730807578], "unit": "score", "name": "Earley", "value": 668.4623889999998}, {"lowerIsBetter": false, "replicates": [13328.947368421053], "unit": "score", "name": "Boyer", "value": 50.00117275419543}, {"lowerIsBetter": false, "replicates": [28388.88888888889], "unit": "score", "name": "RegExp", "value": 32.089491193737786}, {"lowerIsBetter": false, "replicates": [650.6180871828237], "unit": "score", "name": "Splay", "value": 125.25166700000001}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "NavierStokes", "value": 304.7896311066801}], "name": "v8_7", "value": 18984.348341146975}]} 09:51:08 INFO - RETURN: dromaeo_css: 7894.37 09:51:08 INFO - RETURN: kraken: 1424.30 09:51:08 INFO - RETURN: v8_7: 18984.35 09:51:08 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "18984.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1424.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7894.37"}}} 09:51:08 INFO - Return code: 0 09:51:08 INFO - # TBPL SUCCESS # 09:51:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:51:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:51:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:51:08 INFO - 2015-11-24 09:51:08.711 screenresolution[1678:10134] starting screenresolution argv=screenresolution get 09:51:08 INFO - 2015-11-24 09:51:08.713 screenresolution[1678:10134] Display 0: 1600x1200x32@60 09:51:08 INFO - 2015-11-24 09:51:08.719 screenresolution[1679:10137] starting screenresolution argv=screenresolution list 09:51:08 INFO - Available Modes on Display 0 09:51:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:51:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:51:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:51:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:51:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:51:08 INFO - Intel Iris: 09:51:08 INFO - Chipset Model: Intel Iris 09:51:08 INFO - Type: GPU 09:51:08 INFO - Bus: Built-In 09:51:08 INFO - VRAM (Dynamic, Max): 1536 MB 09:51:08 INFO - Vendor: Intel (0x8086) 09:51:08 INFO - Device ID: 0x0a2e 09:51:08 INFO - Revision ID: 0x0009 09:51:08 INFO - Displays: 09:51:08 INFO - Display: 09:51:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:51:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:51:08 INFO - Display Serial Number: 1600x1200 60 09:51:08 INFO - Main Display: Yes 09:51:08 INFO - Mirror: Off 09:51:08 INFO - Online: Yes 09:51:08 INFO - Rotation: Supported 09:51:08 INFO - Return code: 0 09:51:08 INFO - Running post-action listener: _resource_record_post_action 09:51:08 INFO - Running post-run listener: _resource_record_post_run 09:51:10 INFO - Total resource usage - Wall time: 1239s; CPU: 53.0%; Read bytes: 39101952; Write bytes: 689277440; Read time: 425; Write time: 2167 09:51:10 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334901760; Write bytes: 335579136; Read time: 25986; Write time: 613 09:51:10 INFO - run-tests - Wall time: 1209s; CPU: 53.0%; Read bytes: 38180352; Write bytes: 342155776; Read time: 412; Write time: 1516 09:51:10 INFO - Running post-run listener: _upload_blobber_files 09:51:10 INFO - Blob upload gear active. 09:51:10 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:51:10 INFO - Copying logs to upload dir... 09:51:10 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.917921 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2015-11-24 09:51:10.064696) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:51:10.067778) ========= 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.LaKIJGmQZh/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.djHPg5n9pt/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009314 build_url: 'https://queue.taskcluster.net/v1/task/Zw_FrmJuT--4MiDtJIum-w/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-24 09:51:10.091127) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:51:10.091473) ========= 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.LaKIJGmQZh/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.djHPg5n9pt/Listeners TMPDIR=/var/folders/gp/w0knbrzj5_v59wx_4sx69slw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005055 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-24 09:51:10.140572) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 09:51:10.140898) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-24 09:51:10.141638) ========= ========= Total master_lag: 0.36 =========