builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0074 starttime: 1447422582.01 results: success (0) buildid: 20151113033432 builduid: 50f070f61ce644bb854c6fcb56c0fac9 revision: d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.013063) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.013491) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.013799) ========= 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.pCgGu9K8GC/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.wWtfQNW5zV/Listeners TMPDIR=/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005997 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.064561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.064885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.091965) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.092271) ========= 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.pCgGu9K8GC/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.wWtfQNW5zV/Listeners TMPDIR=/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.012606 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.141330) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.141644) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.141997) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.142273) ========= 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.pCgGu9K8GC/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.wWtfQNW5zV/Listeners TMPDIR=/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-13 05:49:42-- 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% 1.41G=0s 2015-11-13 05:49:42 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.220852 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.378042) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.378356) ========= 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.pCgGu9K8GC/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.wWtfQNW5zV/Listeners TMPDIR=/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.151508 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.544232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:42.544609) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a --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 d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pCgGu9K8GC/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.wWtfQNW5zV/Listeners TMPDIR=/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-13 05:49:42,637 truncating revision to first 12 chars 2015-11-13 05:49:42,637 Setting DEBUG logging. 2015-11-13 05:49:42,637 attempt 1/10 2015-11-13 05:49:42,637 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d9813cc43ecc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-13 05:49:42,891 unpacking tar archive at: fx-team-d9813cc43ecc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.511366 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:43.075828) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:43.076149) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:43.095622) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:43.095974) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-13 05:49:43.096409) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-13 05:49:43.096718) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pCgGu9K8GC/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.wWtfQNW5zV/Listeners TMPDIR=/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 05:49:43 INFO - MultiFileLogger online at 20151113 05:49:43 in /builds/slave/test 05:49:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:49:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:49:43 INFO - {'append_to_log': False, 05:49:43 INFO - 'base_work_dir': '/builds/slave/test', 05:49:43 INFO - 'blob_upload_branch': 'Fx-Team', 05:49:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:49:43 INFO - 'branch': 'Fx-Team', 05:49:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:43 INFO - 'config_files': ('talos/mac_config.py',), 05:49:43 INFO - 'default_actions': ('clobber', 05:49:43 INFO - 'read-buildbot-config', 05:49:43 INFO - 'download-and-extract', 05:49:43 INFO - 'populate-webroot', 05:49:43 INFO - 'create-virtualenv', 05:49:43 INFO - 'install', 05:49:43 INFO - 'run-tests'), 05:49:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:43 INFO - 'download_minidump_stackwalk': True, 05:49:43 INFO - 'download_symbols': 'ondemand', 05:49:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:43 INFO - 'installer_path': 'installer.exe', 05:49:43 INFO - 'log_level': 'info', 05:49:43 INFO - 'log_name': 'talos', 05:49:43 INFO - 'log_to_console': True, 05:49:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:49:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:49:43 INFO - 'opt_config_files': (), 05:49:43 INFO - 'pip_index': False, 05:49:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:49:43 INFO - 'cmd': ('bash', 05:49:43 INFO - '-c', 05:49:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:49:43 INFO - 'enabled': True, 05:49:43 INFO - 'halt_on_failure': False, 05:49:43 INFO - 'name': 'check_screen_resolution'},), 05:49:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:49:43 INFO - 'cmd': ('bash', 05:49:43 INFO - '-c', 05:49:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:49:43 INFO - 'enabled': True, 05:49:43 INFO - 'halt_on_failure': False, 05:49:43 INFO - 'name': 'check_screen_resolution'},), 05:49:43 INFO - 'run_cmd_checks_enabled': True, 05:49:43 INFO - 'sps_profile': False, 05:49:43 INFO - 'sps_profile_interval': 0, 05:49:43 INFO - 'suite': 'dromaeojs-e10s', 05:49:43 INFO - 'system_bits': '64', 05:49:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:43 INFO - 'title': 't-yosemite-r5-0074', 05:49:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:43 INFO - 'use_talos_json': True, 05:49:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:49:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:43 INFO - 'work_dir': 'build'} 05:49:43 INFO - ##### 05:49:43 INFO - ##### Running clobber step. 05:49:43 INFO - ##### 05:49:43 INFO - Running pre-action listener: _resource_record_pre_action 05:49:43 INFO - Running main action method: clobber 05:49:43 INFO - rmtree: /builds/slave/test/build 05:49:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:49:47 INFO - Running post-action listener: _resource_record_post_action 05:49:47 INFO - ##### 05:49:47 INFO - ##### Running read-buildbot-config step. 05:49:47 INFO - ##### 05:49:47 INFO - Running pre-action listener: _resource_record_pre_action 05:49:47 INFO - Running main action method: read_buildbot_config 05:49:47 INFO - Using buildbot properties: 05:49:47 INFO - { 05:49:47 INFO - "properties": { 05:49:47 INFO - "buildnumber": 37, 05:49:47 INFO - "product": "firefox", 05:49:47 INFO - "script_repo_revision": "production", 05:49:47 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 05:49:47 INFO - "repository": "", 05:49:47 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 05:49:47 INFO - "buildid": "20151113033432", 05:49:47 INFO - "slavename": "t-yosemite-r5-0074", 05:49:47 INFO - "pgo_build": "False", 05:49:47 INFO - "basedir": "/builds/slave/test", 05:49:47 INFO - "project": "", 05:49:47 INFO - "platform": "yosemite", 05:49:47 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:49:47 INFO - "slavebuilddir": "test", 05:49:47 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:49:47 INFO - "branch": "fx-team", 05:49:47 INFO - "repo_path": "integration/fx-team", 05:49:47 INFO - "stage_platform": "macosx64", 05:49:47 INFO - "builduid": "50f070f61ce644bb854c6fcb56c0fac9", 05:49:47 INFO - "revision": "d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a" 05:49:47 INFO - }, 05:49:47 INFO - "sourcestamp": { 05:49:47 INFO - "repository": "", 05:49:47 INFO - "hasPatch": false, 05:49:47 INFO - "project": "", 05:49:47 INFO - "branch": "fx-team-macosx64-talos", 05:49:47 INFO - "changes": [ 05:49:47 INFO - { 05:49:47 INFO - "category": null, 05:49:47 INFO - "files": [ 05:49:47 INFO - { 05:49:47 INFO - "url": null, 05:49:47 INFO - "name": "https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:49:47 INFO - } 05:49:47 INFO - ], 05:49:47 INFO - "repository": "", 05:49:47 INFO - "rev": "d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a", 05:49:47 INFO - "who": "cbook@mozilla.com", 05:49:47 INFO - "when": 1447419237, 05:49:47 INFO - "number": 6658176, 05:49:47 INFO - "comments": "Backed out changeset d3c232398513 (bug 770156) for devtools bustage", 05:49:47 INFO - "project": "", 05:49:47 INFO - "at": "Fri 13 Nov 2015 04:53:57", 05:49:47 INFO - "branch": "fx-team-macosx64-talos", 05:49:47 INFO - "revlink": "", 05:49:47 INFO - "properties": [ 05:49:47 INFO - [ 05:49:47 INFO - "buildid", 05:49:47 INFO - "20151113033432", 05:49:47 INFO - "Change" 05:49:47 INFO - ], 05:49:47 INFO - [ 05:49:47 INFO - "builduid", 05:49:47 INFO - "50f070f61ce644bb854c6fcb56c0fac9", 05:49:47 INFO - "Change" 05:49:47 INFO - ], 05:49:47 INFO - [ 05:49:47 INFO - "pgo_build", 05:49:47 INFO - "False", 05:49:47 INFO - "Change" 05:49:47 INFO - ] 05:49:47 INFO - ], 05:49:47 INFO - "revision": "d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a" 05:49:47 INFO - } 05:49:47 INFO - ], 05:49:47 INFO - "revision": "d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a" 05:49:47 INFO - } 05:49:47 INFO - } 05:49:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:49:47 INFO - Running post-action listener: _resource_record_post_action 05:49:47 INFO - ##### 05:49:47 INFO - ##### Running download-and-extract step. 05:49:47 INFO - ##### 05:49:47 INFO - Running pre-action listener: _resource_record_pre_action 05:49:47 INFO - Running main action method: download_and_extract 05:49:47 INFO - mkdir: /builds/slave/test/build/tests 05:49: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')]} 05:49:47 INFO - https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:49:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/test_packages.json 05:49:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/test_packages.json 05:49:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:49:47 INFO - Downloaded 1149 bytes. 05:49:47 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:49:47 INFO - Using the following test package requirements: 05:49:47 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:49:47 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:49:47 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:49:47 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:49:47 INFO - u'jsshell-mac.zip'], 05:49:47 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:49:47 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:49:47 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:49:47 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:49:47 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:49:47 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:49:47 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:49:47 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:49:47 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:49:47 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:49:47 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:49:47 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:49:47 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:49: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')]} 05:49:47 INFO - https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:49:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:49:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:49:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/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 05:49:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/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 05:49:49 INFO - Downloaded 17460327 bytes. 05:49:49 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 05:49:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:49:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:49:53 INFO - Return code: 0 05:49: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 05:49: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')]} 05:49:53 INFO - https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:49:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:49:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:49:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/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 05:49:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/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 05:49:55 INFO - Downloaded 17460327 bytes. 05:49:55 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 05:49:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:49:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:50:01 INFO - Return code: 0 05:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:01 INFO - https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:50:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:50:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:50:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/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 05:50:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/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 05:50:01 INFO - Downloaded 11131693 bytes. 05:50:01 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 05:50:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:50:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:50:02 INFO - Return code: 0 05:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:02 INFO - https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:50:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:50:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:50:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:50:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sWrYFiysSAGpJCXR-deKyQ/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 05:50:05 INFO - Downloaded 108693131 bytes. 05:50:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:50:05 INFO - mkdir: /builds/slave/test/properties 05:50:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:50:05 INFO - Writing to file /builds/slave/test/properties/build_url 05:50:05 INFO - Contents: 05:50:05 INFO - build_url:https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:50:05 INFO - Running post-action listener: _resource_record_post_action 05:50:05 INFO - Running post-action listener: set_extra_try_arguments 05:50:05 INFO - ##### 05:50:05 INFO - ##### Running populate-webroot step. 05:50:05 INFO - ##### 05:50:05 INFO - Running pre-action listener: _resource_record_pre_action 05:50:05 INFO - Running main action method: populate_webroot 05:50:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:50:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:50:05 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:50:05 INFO - '../fennec_ids.txt'], 05:50:05 INFO - 'tests': ['tcheck2']}, 05:50:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:50:05 INFO - '--tppagecycles', 05:50:05 INFO - '7'], 05:50:05 INFO - 'tests': ['tsvgm']}}, 05:50:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:50:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:50:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:50:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:50:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:50:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:50:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:05 INFO - 'talos_options': ['--e10s'], 05:50:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:50:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:05 INFO - 'tests': ['damp', 'tps']}, 05:50:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:05 INFO - 'talos_options': ['--e10s'], 05:50:05 INFO - 'tests': ['damp', 'tps']}, 05:50:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:50:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:50:05 INFO - 'other': {'tests': ['a11yr', 05:50:05 INFO - 'ts_paint', 05:50:05 INFO - 'tpaint', 05:50:05 INFO - 'sessionrestore', 05:50:05 INFO - 'sessionrestore_no_auto_restore']}, 05:50:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:50:05 INFO - 'tests': ['a11yr', 05:50:05 INFO - 'ts_paint', 05:50:05 INFO - 'tpaint', 05:50:05 INFO - 'sessionrestore', 05:50:05 INFO - 'sessionrestore_no_auto_restore']}, 05:50:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:50:05 INFO - 'tests': ['a11yr', 05:50:05 INFO - 'ts_paint', 05:50:05 INFO - 'tpaint', 05:50:05 INFO - 'sessionrestore', 05:50:05 INFO - 'sessionrestore_no_auto_restore']}, 05:50:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:50:05 INFO - 'tests': ['a11yr', 05:50:05 INFO - 'ts_paint', 05:50:05 INFO - 'tpaint', 05:50:05 INFO - 'sessionrestore', 05:50:05 INFO - 'sessionrestore_no_auto_restore']}, 05:50:05 INFO - 'other_l64': {'tests': ['a11yr', 05:50:05 INFO - 'ts_paint', 05:50:05 INFO - 'tpaint', 05:50:05 INFO - 'sessionrestore', 05:50:05 INFO - 'sessionrestore_no_auto_restore']}, 05:50:05 INFO - 'other_nol64': {'tests': ['a11yr', 05:50:05 INFO - 'ts_paint', 05:50:05 INFO - 'tpaint', 05:50:05 INFO - 'sessionrestore', 05:50:05 INFO - 'sessionrestore_no_auto_restore']}, 05:50:05 INFO - 'svgr': {'tests': ['tsvgx', 05:50:05 INFO - 'tsvgr_opacity', 05:50:05 INFO - 'tart', 05:50:05 INFO - 'tscrollx', 05:50:05 INFO - 'cart']}, 05:50:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:50:05 INFO - 'tests': ['tsvgx', 05:50:05 INFO - 'tsvgr_opacity', 05:50:05 INFO - 'tart', 05:50:05 INFO - 'tscrollx', 05:50:05 INFO - 'cart']}, 05:50:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:05 INFO - 'tests': ['tp5o']}, 05:50:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:05 INFO - 'talos_options': ['--e10s'], 05:50:05 INFO - 'tests': ['tp5o']}, 05:50:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:05 INFO - 'talos_options': ['--xperf_path', 05:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:05 INFO - 'tests': ['tp5n']}, 05:50:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:50:05 INFO - 'talos_options': ['--e10s', 05:50:05 INFO - '--xperf_path', 05:50:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:50:05 INFO - 'tests': ['tp5n']}}, 05:50:05 INFO - 'talos.zip': {'path': '', 05:50:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:50:05 INFO - Running post-action listener: _resource_record_post_action 05:50:05 INFO - ##### 05:50:05 INFO - ##### Running create-virtualenv step. 05:50:05 INFO - ##### 05:50:05 INFO - Running pre-action listener: _resource_record_pre_action 05:50:05 INFO - Running main action method: create_virtualenv 05:50:05 INFO - Creating virtualenv /builds/slave/test/build/venv 05:50:05 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 05:50:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:50:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:50:06 INFO - Using real prefix '/tools/python27' 05:50:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:50:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:50:10 INFO - Installing pip.................done. 05:50:10 INFO - Return code: 0 05:50:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:10 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 0x103539490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103516228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b8491290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345c9f0>, '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 0x1031bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034508c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/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.wWtfQNW5zV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:50:10 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 05:50:10 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 05:50:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/Render', 05:50:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:50:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:50:10 INFO - 'HOME': '/Users/cltbld', 05:50:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:50:10 INFO - 'LOGNAME': 'cltbld', 05:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:10 INFO - 'MOZ_NO_REMOTE': '1', 05:50:10 INFO - 'NO_EM_RESTART': '1', 05:50:10 INFO - 'PAGER': '/bin/cat', 05:50:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:10 INFO - 'PWD': '/builds/slave/test', 05:50:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:50:10 INFO - 'SHELL': '/bin/bash', 05:50:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wWtfQNW5zV/Listeners', 05:50:10 INFO - 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', 05:50:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:50:10 INFO - 'USER': 'cltbld', 05:50:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:50:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:10 INFO - 'XPC_FLAGS': '0x0', 05:50:10 INFO - 'XPC_SERVICE_NAME': '0', 05:50:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:11 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 05:50:11 INFO - Cleaning up... 05:50:11 INFO - Return code: 0 05:50:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103539490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103516228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b8491290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345c9f0>, '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 0x1031bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034508c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/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.wWtfQNW5zV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/Render', 05:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:50:11 INFO - 'HOME': '/Users/cltbld', 05:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:50:11 INFO - 'LOGNAME': 'cltbld', 05:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:11 INFO - 'MOZ_NO_REMOTE': '1', 05:50:11 INFO - 'NO_EM_RESTART': '1', 05:50:11 INFO - 'PAGER': '/bin/cat', 05:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:11 INFO - 'PWD': '/builds/slave/test', 05:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:50:11 INFO - 'SHELL': '/bin/bash', 05:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wWtfQNW5zV/Listeners', 05:50:11 INFO - 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', 05:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:50:11 INFO - 'USER': 'cltbld', 05:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:11 INFO - 'XPC_FLAGS': '0x0', 05:50:11 INFO - 'XPC_SERVICE_NAME': '0', 05:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:12 INFO - Downloading/unpacking psutil>=0.7.1 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50: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 05:50:14 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:50:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:50:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:14 INFO - Installing collected packages: psutil 05:50:14 INFO - Running setup.py install for psutil 05:50:14 INFO - building 'psutil._psutil_osx' extension 05:50:14 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 05:50:16 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 05:50:16 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 05:50:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:50:17 INFO - building 'psutil._psutil_posix' extension 05:50:17 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 05:50:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:50:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:50:17 INFO - ^ 05:50:17 INFO - 1 warning generated. 05:50:17 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 05:50:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:50:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:50:17 INFO - Successfully installed psutil 05:50:17 INFO - Cleaning up... 05:50:17 INFO - Return code: 0 05:50:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103539490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103516228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b8491290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345c9f0>, '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 0x1031bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034508c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/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.wWtfQNW5zV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:50:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/Render', 05:50:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:50:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:50:17 INFO - 'HOME': '/Users/cltbld', 05:50:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:50:17 INFO - 'LOGNAME': 'cltbld', 05:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:17 INFO - 'MOZ_NO_REMOTE': '1', 05:50:17 INFO - 'NO_EM_RESTART': '1', 05:50:17 INFO - 'PAGER': '/bin/cat', 05:50:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:17 INFO - 'PWD': '/builds/slave/test', 05:50:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:50:17 INFO - 'SHELL': '/bin/bash', 05:50:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wWtfQNW5zV/Listeners', 05:50:17 INFO - 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', 05:50:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:50:17 INFO - 'USER': 'cltbld', 05:50:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:50:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:17 INFO - 'XPC_FLAGS': '0x0', 05:50:17 INFO - 'XPC_SERVICE_NAME': '0', 05:50:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:50:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:50:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:50:20 INFO - Installing collected packages: mozsystemmonitor 05:50:20 INFO - Running setup.py install for mozsystemmonitor 05:50:20 INFO - Successfully installed mozsystemmonitor 05:50:20 INFO - Cleaning up... 05:50:21 INFO - Return code: 0 05:50:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103539490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103516228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b8491290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345c9f0>, '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 0x1031bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034508c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/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.wWtfQNW5zV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:50:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/Render', 05:50:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:50:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:50:21 INFO - 'HOME': '/Users/cltbld', 05:50:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:50:21 INFO - 'LOGNAME': 'cltbld', 05:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:21 INFO - 'MOZ_NO_REMOTE': '1', 05:50:21 INFO - 'NO_EM_RESTART': '1', 05:50:21 INFO - 'PAGER': '/bin/cat', 05:50:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:21 INFO - 'PWD': '/builds/slave/test', 05:50:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:50:21 INFO - 'SHELL': '/bin/bash', 05:50:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wWtfQNW5zV/Listeners', 05:50:21 INFO - 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', 05:50:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:50:21 INFO - 'USER': 'cltbld', 05:50:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:50:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:21 INFO - 'XPC_FLAGS': '0x0', 05:50:21 INFO - 'XPC_SERVICE_NAME': '0', 05:50:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:21 INFO - Downloading/unpacking blobuploader==1.2.4 05:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:23 INFO - Downloading blobuploader-1.2.4.tar.gz 05:50:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:50:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:50:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:50:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:50:25 INFO - Downloading docopt-0.6.1.tar.gz 05:50:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:50:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:50:25 INFO - Installing collected packages: blobuploader, requests, docopt 05:50:25 INFO - Running setup.py install for blobuploader 05:50:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:50:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:50:25 INFO - Running setup.py install for requests 05:50:26 INFO - Running setup.py install for docopt 05:50:26 INFO - Successfully installed blobuploader requests docopt 05:50:26 INFO - Cleaning up... 05:50:26 INFO - Return code: 0 05:50:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:26 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')]} 05:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:26 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')]} 05:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:26 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 0x103539490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103516228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b8491290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345c9f0>, '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 0x1031bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034508c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/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.wWtfQNW5zV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:50:26 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 05:50:26 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 05:50:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/Render', 05:50:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:50:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:50:26 INFO - 'HOME': '/Users/cltbld', 05:50:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:50:26 INFO - 'LOGNAME': 'cltbld', 05:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:26 INFO - 'MOZ_NO_REMOTE': '1', 05:50:26 INFO - 'NO_EM_RESTART': '1', 05:50:26 INFO - 'PAGER': '/bin/cat', 05:50:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:26 INFO - 'PWD': '/builds/slave/test', 05:50:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:50:26 INFO - 'SHELL': '/bin/bash', 05:50:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wWtfQNW5zV/Listeners', 05:50:26 INFO - 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', 05:50:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:50:26 INFO - 'USER': 'cltbld', 05:50:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:50:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:26 INFO - 'XPC_FLAGS': '0x0', 05:50:26 INFO - 'XPC_SERVICE_NAME': '0', 05:50:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:26 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-cz2fB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:26 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-Jeu98j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:26 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-0yTfGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:27 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-ej5ird-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:27 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-CSwTvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:27 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-leF1Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:27 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-e0gKkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:27 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-5X2Iyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:27 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-HqBxCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:27 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-ieQvjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:27 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-0LH052-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:28 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-398W2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:28 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-U2ox5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:28 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-3FqFoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:28 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-j4IBiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:28 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-GAirWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:28 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-dOfFx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:50:28 INFO - Running setup.py install for manifestparser 05:50:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:50:29 INFO - Running setup.py install for mozcrash 05:50:29 INFO - Running setup.py install for mozdebug 05:50:29 INFO - Running setup.py install for mozdevice 05:50:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:50:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:50:29 INFO - Running setup.py install for mozfile 05:50:29 INFO - Running setup.py install for mozhttpd 05:50:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:50:30 INFO - Running setup.py install for mozinfo 05:50:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:50:30 INFO - Running setup.py install for mozInstall 05:50:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:50:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:50:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:50:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:50:30 INFO - Running setup.py install for mozleak 05:50:30 INFO - Running setup.py install for mozlog 05:50:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:50:30 INFO - Running setup.py install for moznetwork 05:50:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:50:30 INFO - Running setup.py install for mozprocess 05:50:31 INFO - Running setup.py install for mozprofile 05:50:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:50:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:50:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:50:31 INFO - Running setup.py install for mozrunner 05:50:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:50:31 INFO - Running setup.py install for mozscreenshot 05:50:31 INFO - Running setup.py install for moztest 05:50:31 INFO - Running setup.py install for mozversion 05:50:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:50:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:50:32 INFO - Cleaning up... 05:50:32 INFO - Return code: 0 05:50:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103539490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103516228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b8491290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345c9f0>, '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 0x1031bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034508c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/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.wWtfQNW5zV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:50:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:50:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:50:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/Render', 05:50:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:50:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:50:32 INFO - 'HOME': '/Users/cltbld', 05:50:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:50:32 INFO - 'LOGNAME': 'cltbld', 05:50:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:32 INFO - 'MOZ_NO_REMOTE': '1', 05:50:32 INFO - 'NO_EM_RESTART': '1', 05:50:32 INFO - 'PAGER': '/bin/cat', 05:50:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:50:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:32 INFO - 'PWD': '/builds/slave/test', 05:50:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:50:32 INFO - 'SHELL': '/bin/bash', 05:50:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wWtfQNW5zV/Listeners', 05:50:32 INFO - 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', 05:50:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:50:32 INFO - 'USER': 'cltbld', 05:50:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:50:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:50:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:32 INFO - 'XPC_FLAGS': '0x0', 05:50:32 INFO - 'XPC_SERVICE_NAME': '0', 05:50:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:50:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:32 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-udq3n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:32 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)) 05:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:32 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-CU60PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:32 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)) 05:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:32 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-axeIRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:32 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)) 05:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:32 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-wdrnh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:32 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)) 05:50:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:32 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-TbOqEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:33 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-57HzUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:33 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-kDR7KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:33 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-1aFc2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:33 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)) 05:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:33 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-xySG2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:33 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)) 05:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:33 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-hTVssN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:33 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-gJfoG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:33 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)) 05:50:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:33 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-XhC4kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:34 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-Dlq6sD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:34 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-4LH7CZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:34 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-3P70Tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:34 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)) 05:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:34 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-FWzTse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:34 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)) 05:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:34 INFO - Running setup.py (path:/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/pip-BxWcZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:34 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)) 05:50:34 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)) 05:50:34 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)) 05:50:34 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)) 05:50:34 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)) 05:50:34 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)) 05:50:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:34 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 05:50:34 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 05:50:34 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 05:50:34 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 05:50:34 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 05:50:34 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 05:50:37 INFO - Downloading blessings-1.5.1.tar.gz 05:50:37 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:50:37 INFO - Installing collected packages: blessings 05:50:37 INFO - Running setup.py install for blessings 05:50:37 INFO - Successfully installed blessings 05:50:37 INFO - Cleaning up... 05:50:37 INFO - Return code: 0 05:50:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:50:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:38 INFO - Reading from file tmpfile_stdout 05:50:38 INFO - Current package versions: 05:50:38 INFO - blessings == 1.5.1 05:50:38 INFO - blobuploader == 1.2.4 05:50:38 INFO - docopt == 0.6.1 05:50:38 INFO - manifestparser == 1.1 05:50:38 INFO - mozInstall == 1.12 05:50:38 INFO - mozcrash == 0.16 05:50:38 INFO - mozdebug == 0.1 05:50:38 INFO - mozdevice == 0.47 05:50:38 INFO - mozfile == 1.2 05:50:38 INFO - mozhttpd == 0.7 05:50:38 INFO - mozinfo == 0.9 05:50:38 INFO - mozleak == 0.1 05:50:38 INFO - mozlog == 3.0 05:50:38 INFO - moznetwork == 0.27 05:50:38 INFO - mozprocess == 0.22 05:50:38 INFO - mozprofile == 0.27 05:50:38 INFO - mozrunner == 6.11 05:50:38 INFO - mozscreenshot == 0.1 05:50:38 INFO - mozsystemmonitor == 0.0 05:50:38 INFO - moztest == 0.7 05:50:38 INFO - mozversion == 1.4 05:50:38 INFO - psutil == 3.1.1 05:50:38 INFO - requests == 1.2.3 05:50:38 INFO - wsgiref == 0.1.2 05:50:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103539490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103516228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa0b8491290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345c9f0>, '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 0x1031bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034508c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/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.wWtfQNW5zV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:50:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:50:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/Render', 05:50:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:50:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:50:38 INFO - 'HOME': '/Users/cltbld', 05:50:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:50:38 INFO - 'LOGNAME': 'cltbld', 05:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:38 INFO - 'MOZ_NO_REMOTE': '1', 05:50:38 INFO - 'NO_EM_RESTART': '1', 05:50:38 INFO - 'PAGER': '/bin/cat', 05:50:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:38 INFO - 'PWD': '/builds/slave/test', 05:50:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:50:38 INFO - 'SHELL': '/bin/bash', 05:50:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wWtfQNW5zV/Listeners', 05:50:38 INFO - 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', 05:50:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:50:38 INFO - 'USER': 'cltbld', 05:50:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:50:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:38 INFO - 'XPC_FLAGS': '0x0', 05:50:38 INFO - 'XPC_SERVICE_NAME': '0', 05:50:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:50:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:50:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:50:38 INFO - Cleaning up... 05:50:38 INFO - Return code: 0 05:50:38 INFO - Running post-action listener: _resource_record_post_action 05:50:38 INFO - Running post-action listener: _start_resource_monitoring 05:50:38 INFO - Starting resource monitoring. 05:50:38 INFO - ##### 05:50:38 INFO - ##### Running install step. 05:50:38 INFO - ##### 05:50:38 INFO - Running pre-action listener: _resource_record_pre_action 05:50:38 INFO - Running main action method: install 05:50:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:38 INFO - Reading from file tmpfile_stdout 05:50:38 INFO - Detecting whether we're running mozinstall >=1.0... 05:50:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:50:38 INFO - Reading from file tmpfile_stdout 05:50:38 INFO - Output received: 05:50:38 INFO - Usage: mozinstall [options] installer 05:50:38 INFO - Options: 05:50:38 INFO - -h, --help show this help message and exit 05:50:38 INFO - -d DEST, --destination=DEST 05:50:38 INFO - Directory to install application into. [default: 05:50:38 INFO - "/builds/slave/test"] 05:50:38 INFO - --app=APP Application being installed. [default: firefox] 05:50:38 INFO - mkdir: /builds/slave/test/build/application 05:50:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:50:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:51:19 INFO - Reading from file tmpfile_stdout 05:51:19 INFO - Output received: 05:51:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:51:19 INFO - Running post-action listener: _resource_record_post_action 05:51:19 INFO - ##### 05:51:19 INFO - ##### Running run-tests step. 05:51:19 INFO - ##### 05:51:19 INFO - Running pre-action listener: _resource_record_pre_action 05:51:19 INFO - Running main action method: run_tests 05:51:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:51:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:51:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:51:19 INFO - 2015-11-13 05:51:19.690 screenresolution[1630:7509] starting screenresolution argv=screenresolution get 05:51:19 INFO - 2015-11-13 05:51:19.694 screenresolution[1630:7509] Display 0: 1600x1200x32@60 05:51:19 INFO - 2015-11-13 05:51:19.701 screenresolution[1631:7511] starting screenresolution argv=screenresolution list 05:51:19 INFO - Available Modes on Display 0 05:51:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:51:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:51:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:51:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:51:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:51:19 INFO - Intel HD Graphics 3000: 05:51:19 INFO - Chipset Model: Intel HD Graphics 3000 05:51:19 INFO - Type: GPU 05:51:19 INFO - Bus: Built-In 05:51:19 INFO - VRAM (Total): 512 MB 05:51:19 INFO - VRAM (Dynamic, Max): 10 05:51:19 INFO - Vendor: Intel (0x8086) 05:51:19 INFO - Device ID: 0x0116 05:51:19 INFO - Revision ID: 0x0009 05:51:19 INFO - Displays: 05:51:19 INFO - Display: 05:51:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:51:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:51:19 INFO - Display Serial Number: 1600x1200 60 05:51:19 INFO - Main Display: Yes 05:51:19 INFO - Mirror: Off 05:51:19 INFO - Online: Yes 05:51:19 INFO - Rotation: Supported 05:51:19 INFO - Return code: 0 05:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:51:19 INFO - Python 2.7.3 05:51:19 INFO - Return code: 0 05:51:19 INFO - grabbing minidump binary from tooltool 05:51: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')]} 05:51:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345c9f0>, '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 0x1031bcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1034508c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:51:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:51:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:51:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:51:20 INFO - Return code: 0 05:51:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:51:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:51:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:51:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:51:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0074', '--webServer', 'localhost'] in /builds/slave/test/build 05:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0074 --webServer localhost 05:51:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pCgGu9K8GC/Render', 05:51:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:51:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:51:20 INFO - 'HOME': '/Users/cltbld', 05:51:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:51:20 INFO - 'LOGNAME': 'cltbld', 05:51:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:51:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:51:20 INFO - 'MOZ_NO_REMOTE': '1', 05:51:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:51:20 INFO - 'NO_EM_RESTART': '1', 05:51:20 INFO - 'PAGER': '/bin/cat', 05:51:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:51:20 INFO - 'PWD': '/builds/slave/test', 05:51:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:51:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:51:20 INFO - 'SHELL': '/bin/bash', 05:51:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wWtfQNW5zV/Listeners', 05:51:20 INFO - 'TMPDIR': '/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/', 05:51:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:51:20 INFO - 'USER': 'cltbld', 05:51:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:51:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:51:20 INFO - 'XPC_FLAGS': '0x0', 05:51:20 INFO - 'XPC_SERVICE_NAME': '0', 05:51:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:51:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0074', '--webServer', 'localhost'] with output_timeout 3600 05:51:20 INFO - mozversion INFO | application_buildid: 20151113033432 05:51:20 INFO - mozversion INFO | application_changeset: d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a 05:51:20 INFO - mozversion INFO | application_display_name: Nightly 05:51:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:51:20 INFO - mozversion INFO | application_name: Firefox 05:51:20 INFO - mozversion INFO | application_remotingname: firefox 05:51:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:51:20 INFO - mozversion INFO | application_vendor: Mozilla 05:51:20 INFO - mozversion INFO | application_version: 45.0a1 05:51:20 INFO - mozversion INFO | platform_buildid: 20151113033432 05:51:20 INFO - mozversion INFO | platform_changeset: d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a 05:51:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:51:20 INFO - mozversion INFO | platform_version: 45.0a1 05:51:20 INFO - 2015-11-13 05:51:20,447 DEBUG : using testdate: 1447422680 05:51:20 INFO - 2015-11-13 05:51:20,447 DEBUG : actual date: 1447422680 05:51:20 INFO - 2015-11-13 05:51:20,460 INFO : starting webserver on 'localhost:49264' 05:51:20 INFO - 2015-11-13 05:51:20,461 INFO : Starting test suite t-yosemite-r5-0074.e 05:51:20 INFO - 2015-11-13 05:51:20,461 INFO : Starting test dromaeo_css 05:51:20 INFO - 2015-11-13 05:51:20,461 DEBUG : operating with platform_type : mac_ 05:51:20 INFO - 2015-11-13 05:51:20,462 INFO : Initialising browser for dromaeo_css test... 05:51:20 INFO - 2015-11-13 05:51:20,496 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/tmpbCOmg1/profile http://localhost:49264/getInfo.html 05:51:24 INFO - 2015-11-13 05:51:24,899 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:51:24 INFO - 2015-11-13 05:51:24,900 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:51:24 INFO - 2015-11-13 05:51:24,900 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:51:24 INFO - 2015-11-13 05:51:24,900 DEBUG : BROWSER_OUTPUT: __metrics 05:51:25 INFO - 2015-11-13 05:51:25,571 INFO : Browser initialized. 05:51:25 INFO - 2015-11-13 05:51:25,571 INFO : Running cycle 1/1 for dromaeo_css test... 05:51:25 INFO - 2015-11-13 05:51:25,572 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/tmpbCOmg1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:51:37 INFO - 2015-11-13 05:51:37,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 240439296 05:51:37 INFO - 2015-11-13 05:51:37,766 DEBUG : BROWSER_OUTPUT: 05:52:27 INFO - 2015-11-13 05:52:27,640 DEBUG : BROWSER_OUTPUT: 1447422747634 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] 05:54:38 INFO - 2015-11-13 05:54:38,736 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49264/tests/dromaeo/cssquery-ext.html) 05:54:39 INFO - 2015-11-13 05:54:39,846 DEBUG : BROWSER_OUTPUT: RSS: Main: 268349440 05:54:39 INFO - 2015-11-13 05:54:39,846 DEBUG : BROWSER_OUTPUT: 05:57:42 INFO - 2015-11-13 05:57:42,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-ext.html (next: http://localhost:49264/tests/dromaeo/cssquery-jquery.html) 05:57:42 INFO - 2015-11-13 05:57:42,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 273133568 05:57:42 INFO - 2015-11-13 05:57:42,622 DEBUG : BROWSER_OUTPUT: 06:00:44 INFO - 2015-11-13 06:00:44,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49264/tests/dromaeo/cssquery-mootools.html) 06:00:44 INFO - 2015-11-13 06:00:44,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 275259392 06:00:44 INFO - 2015-11-13 06:00:44,959 DEBUG : BROWSER_OUTPUT: 06:03:46 INFO - 2015-11-13 06:03:46,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49264/tests/dromaeo/cssquery-prototype.html) 06:03:47 INFO - 2015-11-13 06:03:47,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 279638016 06:03:47 INFO - 2015-11-13 06:03:47,275 DEBUG : BROWSER_OUTPUT: 06:06:49 INFO - 2015-11-13 06:06:49,951 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49264/tests/dromaeo/cssquery-yui.html) 06:06:50 INFO - 2015-11-13 06:06:50,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 283467776 06:06:50 INFO - 2015-11-13 06:06:50,573 DEBUG : BROWSER_OUTPUT: 06:09:52 INFO - 2015-11-13 06:09:52,727 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/dromaeo/cssquery-yui.html (next: http://localhost:49264/tests/dromaeo/cssquery-dojo.html) 06:09:52 INFO - 2015-11-13 06:09:52,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 289136640 06:09:52 INFO - 2015-11-13 06:09:52,978 DEBUG : BROWSER_OUTPUT: 06:09:52 INFO - 2015-11-13 06:09:52,978 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:09:52 INFO - 2015-11-13 06:09:52,978 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:09:52 INFO - 2015-11-13 06:09:52,978 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:09:52 INFO - 2015-11-13 06:09:52,978 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:09:52 INFO - 2015-11-13 06:09:52,980 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2708.34999600096;2724.6594175728032;2784.749372556468;2790.135058131978;2797.81814182078;4601.378813860128;4625.4911959684405;4655.255159174532;4685.67200295979;4747.05058988202;4441.356003379508;4573.3368661544055;4578.885527861797;4620.653450991173;4699.506551812062;4265.488141423026;4342.956570434302;4350.869473915787;4426.77866106695;4480.798364073608;4088.9386659200136;4405.140997505488;4459.799309031101;4469.240229161034;4543.886402839939;4242.469691288589;4305.31115021595;4371.584699453579;4377.190219809346;4420.6242469390145;4378.387025816388;4412.580804823537;4417.4919884213405;4447.755373454459;4474.082813023322;4398.516163222043;4417.690761646686;4434.002349471375;4465.017696106851;4470.08363285529;4351.977285337943;4493.573110554492;4573;4591.012932219555;4681.368015317957;4863.489333619989;4899.191633380488;4964.180910149821;4976.850694479172;5004.674696144775;5047.9495205048215;5063.594912406998;5068.518490743373;5070.163423035195;5099.133147364957;4467.6425885929375;4624.44506659203;4633.953660463386;4673.205555055649;4750.097481478508;5157.123289040872;5177.948220517746;5221.399539052982;5230.215467679803;5231.24146998683;4682.719036857799;4921.557059864558;4933.58064564516;4971.130052240844;5040.798368065236;4927.507249275044;4967.90064198714;5049.267856160836;5059.392872855281;5085.6948583084395;4963.751812409365;4965.255211718271;4975.577075948585;5005.72468514228;5046.6719663221775;4913.950860491421;4969.602431805447;4982.526659967298;4996.050750357494;5032.597392208614;3814.6376094271;3821.885343439701;3885.8834234972996;3917.196974620196;3928.332183528807;3496.493008513751;3528.259065596202;3536.487209354629;3537.858485660596;3558.466230065459;4434.955650443519;4523.84166554169;4660.324252983299;4715.363425937523;4728.95271047292;4836.395450568679;4918.852434426902;4925.7783399747095;4930.161872481687;4980.526849949321;4669.906601867943;4673.976630116896;4687.554682305175;4701.835435759732;4704.15325241453;4174.269502836992;4279.7218180818145;4388.9122217556105;4425.114977004612;4469.508354081048;5010.173321401928;5070.340855688737;5073.720945347967;5130;5151.665141765773;5030.974845125897;5034.823781167642;5040.243963405518;5069;5106.336176297058;5015.097282489041;5124.30821839047;5166.044281807877;5177.068127737043;5228.6078544110105;4903.730294833818;4932.975335123445;4938.1358262304675;4944;4976.353074100344;4875.975620121877;4876.561109500162;4894.143524883202;5001.64988450805;5043.117454445384;4793.712377257376;4889.266610008527;4903.632227583017;4907.950920490749;4919.4834542373965;4694.859154225379;4744.525547445228;4827.927581086356;4869.95130048695;4892.363992681071;4651.348811166507;4672.065586882569;4710.317004034464;4758.452777930583;4824.831130910401;4793.520647935178;4876.609871210224;4899.755012249445;4911.50884911506;4915.557599816034;4525.321201819754;4629.421322334708;4651.697639653412;4811.591014763644;4867.026594681149 06:09:52 INFO - 2015-11-13 06:09:52,981 DEBUG : BROWSER_OUTPUT: |1;ext.html;466.73862636923326;488.8240233515934;504.4224363104246;510.0945821167428;513.7533983687828;27090.86454567727;27630.723692763066;27704.445911081766;27807.304817379576;28032;37238.813805930935;37587.81206093972;37703.4344484833;37768.24463510728;38191;8101.837963240731;8157.102718700939;8274.544900030496;8336.62485188165;8347.624356903923;8022.719204827832;8196.75409737706;8216.055153657346;8224.259816616503;8224.753257402288;7999.720009799658;8130.146334634866;8143.714969976052;8184;8217.342612591008;8112.553809540473;8182.099969003405;8200.794980125485;8252.752417427457;8306.875396869053;7882.251186137365;8019.879701804478;8021.398395120331;8095.635696393676;8117.512949223006;34214.315713685835;34680.479792803126;34802.607895684145;35125.29749405023;35287.29425411503;2162.91348346066;2303.581569405947;2346.8005219556358;2600.479904019204;2679.0355472030055;25669.3582660435;26695.73304266952;26866.19401417941;27131.45737085267;27959;2109.95780084399;2157.1587081038406;2166.534195148035;2172.196287373682;2175.4670105824016;225388;227185;229234;229970;231655;43971.78014109909;52677.209841852404;52848.735756321745;53545.46454535483;53946.19080713792;43341;54666.180007299925;55687;56675.43324566784;56746;14195.716085678436;14702.55892323232;14706.852931470763;14780.63048423798;14785.778213326808;10955.397453139994;11074.224804263786;11107.278026928223;11118.666440006813;11242.325460472397;17728.202230899642;18181.7272740909;18193.818061819213;18252.908735456236;18316.542086447946;7544.773656790196;7780.649870755829;7796.376289896794;7874.448788584744;7920.168382319889;845.0746432656232;847.8516259654535;856.5674334461182;932.4125800745487;967.57426732239;25680;26539.46921061568;27017.45965080727;27062;27125.86437067802;926.7868390270276;941.0542404883049;985.6796541124163;1009.0968583118068;1044.921630877672;12416.441260143316;13203.537876174289;13768.449262029406;14080.225587592577;14160.079594826304;338682;345903;346911;349951;350729;49321.753391233535;50035;50202.49797502051;50203.74898125486;50771;1204.8915597596083;1226.0926914083514;1226.533917111492;1232.8890399863876;1236.6042866282883;25372;25522.489550209262;25837.483250335263;26017.73982260229;26105;40722.59277407188;40862.59137408588;40923.18153636851;41337.58662413337;41338.1732365345;247177;251178;253810;254618;254977;27050.864745676146;38057.61942380541;40411.39382909318;40766.79616601898;40895;36519.08702282358;36883.262334753694;37277.440838387985;37287.881363559136;37935.24129517449;30332.84833575818;31820.840895795372;31864;31959;32127.518087228244;30476;30840.38319233558;30953.69046309508;30998.535021974236;34252;31021.534676979412;31131;31399.372012559164;31641.20896977594;32477;25922.481550369263;26213.606795898457;28358.432831342845;28428.43143137167;28642.85678571594;20441.795582044586;20446.38660840177;20490.59018819645;20654.89672551688;20681.27615533449 06:09:52 INFO - 2015-11-13 06:09:52,984 DEBUG : BROWSER_OUTPUT: |2;jquery.html;288.7011942639369;288.7040783197224;290.78191356482637;292.36410806495877;298.6073313592625;8722.825543489127;8873.95563022184;14811.851881481181;14907.478238261663;15526.456574019898;9888.703338899844;10015.69952901414;10239.948800256007;10241.539130739116;10352.37885726857;3829.636184562462;3936.5472970608316;3946.980265098685;3968.30554652936;3978.7214894957365;2970.2425881400213;2992.685767994362;3959.346707793225;4129.979350103245;4258.254805409041;4162.1675664867;4233.068724880522;4239.152169566084;4243.915121697564;4247.065645557972;4070.1656160487028;4174.102567947891;4179.435776170239;4231.196072746184;4242.3212286034395;3552.6447355264268;3554.573451185848;3557.573091229069;3586.0855481852223;3606.04439823447;11404.94297528507;11557.653270401901;11679.649610511698;11707.53169873204;11763.647090587296;1655.6192075822507;1668.6329007618303;1676.4132553606262;1681.5711993441716;1708.8205738397414;8050.4364694471415;8200.958995205045;8245.340372770164;8291.83416331676;8464.66141354345;1311.5081844308384;1343.0799902067017;1364.986350136496;1381.896357773161;1416.419268100074;50465.74767126141;52392.21411678828;52539.94920101615;52617.210741838906;53062.73468632671;5438.15708565173;5534.446555344514;5544.944550554524;5627.155926610959;5666.97166514173;6365.36346365369;6381.521385896076;6411.711472983727;6457.063725759738;6463.095166676669;4624.306354046853;4708.764561771898;4719.221328480762;4731.503192164842;4735.502772208937;4684.718916864999;4697.718136911728;4716.151092803259;4818.71087734737;5036.622253331015;2484.59004264298;2506.511230310072;2517.1315896015844;2528.7091984422027;2545.707243667002;886.3928209176735;891.6032365597247;893.7988952485639;919.4483310014072;950.8431108867098;352.9446953608743;365.56315203331764;393.9054626889583;396.7363945832533;399.53172092559726;9360.391574547633;9879.506024698736;9914.950425247971;9925.503724813874;9947.80104397908;387.56399051067547;390.4670125278974;391.8256375912691;394.91509325495156;418.11359916976204;5289.3917199521775;5348.518633322942;5388.084025715638;5457.426970168075;5545.972270138624;496723;509066;537759;541767;544732;63979;64183;64241.678791606675;65247;66309.66845165743;422.3306059895039;427.31842710876106;429.06677975403375;429.91401719656193;431.7905815679393;9313.39462934907;9399.859002114837;9417.811643767223;9631.181349585364;9660.3237773358;29801.25496862596;30762;31006.84496577593;31553.211169720023;31651;37094;38189;38574;39231.2153756929;42890.78554607207;5208.53123218897;5287.339082614673;5389.865253368697;5424.430434804446;5453.209284653623;9517.476538790434;10155.136813370946;10173.694789156338;10180.287379883337;10334.224933129895;8297.58512074406;8484.660613575388;8572.957135214285;8744.650213991368;8776.648934042567;8519.531425771394;8606.65573377058;8647.0920553341;8678.652853885775;8809.251213646912;8614.655413783628;8795.428297160664;8944.642214311614;8982.146696063863;9019.143181397756;4943.703377797344;5395.271638328933;5424.647397919122;5473.397926228191;5516.310461192351;8589.312854971462;8625.654973800978;8697.6086076128;8961.283097352065;9062.773430664287 06:09:52 INFO - 2015-11-13 06:09:52,986 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1239.0706969772673;1247.83154274173;1274.5156840400646;1546.7989161409007;1626.5120463860853;5868.559858010655;6300.30696623371;6662.433693136083;7192.136943566773;7206.8558628827395;6563.7046332915015;6752.966235168818;6820.761273355433;6848.623325717083;6874.415674667647;1871.8876867387967;1901.0684764465382;1901.306023301492;1907.3229003703625;1909.4367161687335;1888.9905550472229;1904.7047707605343;1913.1677720191692;1947.4449781812186;1953.6190442863647;1872.7378167056622;1895.895725735084;1899.3257393625272;1899.4586542835295;1903.6002439487725;1850.3708739028727;1865.990670046648;1869.7849747279101;1870.9064546772606;1877.7934427212995;1877.0896115384028;1913.9712904306446;1921.5484361175113;1933.3136736458637;1941.398166568354;6888.793336199922;6941.5140940134215;6951.582905025664;6973.825654358631;6977.930220697779;4003.7597744135446;4067.572904845008;4093.038136038029;4107.527634322061;4153.563875793058;2515.1071369663687;2552.221572420411;2572.164046684835;2573.961390579143;2683.8658067096567;808.3452403553141;816.8897198878194;836.1554829622065;843.32665450522;845.9154084591553;9153.81692366149;9167.404118732262;9191.126842949909;9194.35639505235;9216.262698984065;3604.243108947098;3625.148090198801;3654.1778099927305;3656.2504686539196;3660.3411385950253;8030.839383212303;8044.919550804534;8078.192180781993;8086.919130808734;8127.3091787198755;4149.813258403379;4162.91674166515;4185.351270553069;4191.6856235781825;4231;3312.38720836646;3384.035549868325;3775.188334508094;3789.1285004449132;3798.3922572388838;3106.3476669899123;3187.282861356223;3198.5841840561043;3205.9038228853174;3226.8547915343865;1006.7332156978407;1028.4651980969854;1035.2649618770756;1041.0786453988276;1047.643801107627;919.9540022998823;963.633819148719;974.741693451236;1173.3487914207526;1178.9941050294865;6340.239171299474;6370.044493325945;6387.2335319761;6398.936010639927;6425.518086143465;992.9205663546899;1012.9746756331151;1025.5436330832856;1038.5222797513077;1040.6669865643073;4867.318575399447;5041.344625198701;5061.063703214917;5063.139266324733;5064.721440320818;8014.639341229658;8105.473144245723;8275.213854683796;8282.917170828214;8287.544185069879;8079.111297757242;8131.5527645978855;8147.877781833277;8200.917990820135;8241.546714930617;6440.871182576416;6457;6475.7085931133215;6501.739930402731;6505.739770409131;6074.210352654127;6181;6236.968815155895;6260.280067792262;6264.718087685974;6787.626680532618;7207.13514378278;7213.458990575623;7217.06178196831;7292.635368231673;7200;7380.926190738024;7389.926100738924;7404.037475128199;7471.402287816853;5403.567714582902;5524.723763811874;6026.487748541248;6104.633721976696;6127.754889804358;6332.746690132343;6520.380563846427;6528.608283503005;6572.8356791080605;6617.139771829631;6076.270847498328;6130.693465326805;6163;6208.068789681584;6246.312905580292;6008.909866351921;6052.334243233329;6091.908621370594;6134.693265336805;6186.628802271878;6163.414475624809;6192.938070619236;6226.377362263737;6235.158253635701;6298.401651843067;5632.2678051853;5656.3495198051105;5674.9785038693435;5701.315842098975;5716.456936591017;5484.369297530676;5710.885782284414;5727.627704199213;5745.454181852718;5750.424957504216 06:09:52 INFO - 2015-11-13 06:09:52,989 DEBUG : BROWSER_OUTPUT: |4;prototype.html;262.90141197051105;264.97482739139787;269.8111322074548;279.1179871605726;286.2600178538478;5429.4570542945685;5439.728013599324;5513.476219759126;5616.213730077788;5630.239917611127;5537.8061767838135;5670.858228544288;5681.517071048956;5682.602217844742;5709.086546152606;4319.200947824663;4354.042110735633;4354.216241076605;4374.803133858984;4379.75911324877;4329.718568293067;4336.392904993303;4357.760323182224;4359.062801497677;4375.365571992059;4181.874543763677;4294.184105020036;4297.1405718856195;4319.200947824646;4348.934765978497;4238.576142385752;4272.423222864904;4287.849925252601;4298.247806633826;4328.523862375137;3689.782371817294;3701.2967536168044;3703.4444833275224;3705.2033812730124;3714.312852122339;5426.565874730012;5454.972725136349;5471.261379713727;5528.75120619573;5537.667739935617;4504.121696269229;4596.3794887690065;4743.596794272491;4745.21703918853;4792.640551958617;5637.323521177444;5721.628094173865;5731.914021289684;5756.107803290497;5763.567732420043;3814.275287695329;3817.675497582709;3823.751456155341;3825.196708691178;3876.4379165021196;5991.370906054889;6098.847528811815;6100.633961962297;6116.021436570172;6128.233970753656;3752.5872154063577;3898.922021559553;3902.6292502212814;3910.432987216838;3919.6668283195677;3984.1234928315725;3993.600639935983;4002.699797515198;4012.8996775080855;4041.7574945503366;4656.837010704609;4659.534046595313;4669.2062349400685;4670.906581868411;4695.366125573004;5802.535797136219;5809.535237181015;5810.6513609183585;5888.676122813286;5902.970485147547;1341.2824139085542;1371.6570857285678;1385.1273697570466;1386.8890488760876;1396.4972609860442;884.8893888263967;885.0087901550305;890.7862113092812;890.9109089091039;892.607252808762;5460.399356070829;5479.287692600016;5482.533984611273;5486.231927530149;5536.7231638418725;6019.217501724747;6029.577929544977;6047.516198704093;6054.576179667469;6062.727177277033;5400.540954018874;5422.53908417781;5430.158325459481;5439.592030597721;5452.59105567084;3129.4054129715737;3206.5671134397026;3229.838508074587;3238.3037646906027;3249.1389781707867;6063.393660633901;6112.541559383064;6146.293176284695;6148.815535533941;6157.138000679908;6112.847178820565;6116.908246376308;6147.139400483936;6147.293061297919;6156.26124865019;6068.969655151696;6099.146119543178;6109.419605137505;6111.57218994675;6118.908216376758;5993.31076926159;6002.819915402545;6036.336003039574;6054.54590905675;6073.726682299395;5744.798932037359;5910.940890591039;5923.49650279731;5925.200097986716;5932.110183472513;6185.134081228542;6185.8144255672405;6190.7523699051535;6207.099970504342;6271.404216599416;3721.7953012584567;3733.6826369757787;3784.1863999240295;3812.1232116613887;3823.9044023899623;5793.826185214451;5984.940150598438;6012;6022.156898034191;6022.7289771959495;5703.258576385209;5733.512651424676;5877.794277200277;5903.409659034062;5914.9944509432635;5844.561657875592;5883.735231914488;5889.734961926638;5932.317783454958;5951.613145145551;5567.8608034797835;5720.771169153188;5758.740856661544;5771.769129234952;5776.768929242783;5809.738561764646;5879.088741245114;5899.528037757055;5904.025835737055;5931.436513531207;5699.259096317618;5729.4843464088435;5745.540356771532;5752.856178595402;5758.62568933018 06:09:52 INFO - 2015-11-13 06:09:52,989 DEBUG : BROWSER_OUTPUT: |5;yui.html;574.262073235892;606.9180660610816;649.7563413719855;655.8065370715639;657.2901266632038;11262.099032077434;11606.013488853436;11662.825057624143;11671.766564668713;11948.581799637015;11220.214584979034;11222.046126079293;11238.438078096104;11247.325160490376;11289.604863829767;773.3349319585152;786.5280831501111;790.1426951757321;791.1179035375573;798.0423491809822;601.7923816283375;618.2117799805239;771.8340556780291;801.390942883407;813.9906515920246;824.7855557555049;835.7242110103651;845.9492430454162;847.0428415890036;848.6478111583716;835.2524490580896;835.8453686068096;836.1304243586662;837.6063250272363;853.63293783673;619.8729260501586;620.3083561828573;623.4825095170997;627.0249761620678;627.5042716254154;11671.883281167164;11796.764064718744;11819.822702659467;11836.230645008047;12068.09489288298;8065.395095367812;8307.08622051574;8544.829103417958;9899.554520046615;10284.897151028468;7728.922710772877;7840.176781437924;7877.527348359117;8058.315043221333;8409.243168114837;2645.5899335603012;2651.9867400663065;2658;2668.2929023808706;2676.424568717735;37615;38050.80974595137;38104.80947595272;38124.809375952944;38330;5764.308283005982;5864.354920958776;5898.262717160355;5900.793472228537;6141.048137538689;10312.27814053009;10334.5349459273;10335.069843714102;10345.482725863827;10384.636537721144;5150.27896094547;5222.373315202124;5306.044911915815;5411.242426060355;5435.945640543544;3150.984245078806;3151.6218053833686;3204.5033019881957;3223.790453620554;3269.983650081734;2445.4986727720775;2464.742981079662;2471.270975062361;2479.5784716598223;2486.9554786989147;350.76323481649786;360.7132329797817;368.0559365228181;369.09755647442284;370.8683417386789;411.2925767679586;463.84502588554255;494.87875470509954;496.3919198981219;509.1039770004744;6644.966775166094;6716.529842910949;6812.591244525344;6813.523053386215;6991.475639327071;355.6088302866826;377.6242638574636;476.86647738632547;498.3372115086926;516.7700373333905;3236.6116066072223;3240.5301231321796;3268.967310326914;3288.3423315337027;3364.915877103043;51956;52611.210831837554;52994.73502632462;53142.73428632832;53432.73283633557;43050.35424468636;43160.352594711105;43329.78335108367;43480.56519434828;43883.78058109689;39597.80201098976;41346.37980430296;41534.1693166135;42307.36538951918;44717.99999999935;7211.206767255493;7247.2390399009455;7259.491835571459;7485.0643669541305;7489.66296516669;31476.527852082694;31679.683203167675;31694.683053170094;31829.36341273208;32452.675473244966;37887;38133.427998579486;40790.71697471723;41085.58914410937;41369.37945930753;9130.452172869649;9424.198943089914;9498.525073746423;9748.122668959828;9960.750981225527;9432.481213533321;9965.10314071737;10170.542325595514;10282.691519254435;10561.260711750103;9038.096190381173;9099.408538444979;9164;9482.525873706425;9772.218222542037;9121.133492318218;9141.26869850397;9190.494522801042;9299.953500232456;9928.851067234142;8897.421667591585;9134.771630709285;9145.725628231165;9203.171714545722;9453.054694530767;7674.462787605037;7685.423593230642;7801.570913599579;7997.360211182975;8859.158379953895;7472.775816725507;7483;7517.210692877169;7565;8056.7180148694515 06:09:52 INFO - 2015-11-13 06:09:52,990 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:09:52 INFO - 2015-11-13 06:09:52,990 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:09:52 INFO - 2015-11-13 06:09:52,990 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,285 06:09:52 INFO - 2015-11-13 06:09:52,990 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:09:52 INFO - 2015-11-13 06:09:52,990 DEBUG : BROWSER_OUTPUT: __startTimestamp1447423792976__endTimestamp 06:09:52 INFO - 2015-11-13 06:09:52,991 DEBUG : BROWSER_OUTPUT: 06:09:52 INFO - 2015-11-13 06:09:52,991 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:09:52 INFO - 2015-11-13 06:09:52,991 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:09:52 INFO - 2015-11-13 06:09:52,991 DEBUG : BROWSER_OUTPUT: 06:09:52 INFO - 2015-11-13 06:09:52,991 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4648.01 Median:4747.05 stddev:493.93 (10.4%) stddev-sans-first:471.43 06:09:52 INFO - 2015-11-13 06:09:52,993 DEBUG : BROWSER_OUTPUT: Values: 2708.3 2724.7 2784.7 2790.1 2797.8 4601.4 4625.5 4655.3 4685.7 4747.1 4441.4 4573.3 4578.9 4620.7 4699.5 4265.5 4343.0 4350.9 4426.8 4480.8 4088.9 4405.1 4459.8 4469.2 4543.9 4242.5 4305.3 4371.6 4377.2 4420.6 4378.4 4412.6 4417.5 4447.8 4474.1 4398.5 4417.7 4434.0 4465.0 4470.1 4352.0 4493.6 4573.0 4591.0 4681.4 4863.5 4899.2 4964.2 4976.9 5004.7 5047.9 5063.6 5068.5 5070.2 5099.1 4467.6 4624.4 4634.0 4673.2 4750.1 5157.1 5177.9 5221.4 5230.2 5231.2 4682.7 4921.6 4933.6 4971.1 5040.8 4927.5 4967.9 5049.3 5059.4 5085.7 4963.8 4965.3 4975.6 5005.7 5046.7 4914.0 4969.6 4982.5 4996.1 5032.6 3814.6 3821.9 3885.9 3917.2 3928.3 3496.5 3528.3 3536.5 3537.9 3558.5 4435.0 4523.8 4660.3 4715.4 4729.0 4836.4 4918.9 4925.8 4930.2 4980.5 4669.9 4674.0 4687.6 4701.8 4704.2 4174.3 4279.7 4388.9 4425.1 4469.5 5010.2 5070.3 5073.7 5130.0 5151.7 5031.0 5034.8 5040.2 5069.0 5106.3 5015.1 5124.3 5166.0 5177.1 5228.6 4903.7 4933.0 4938.1 4944.0 4976.4 4876.0 4876.6 4894.1 5001.6 5043.1 4793.7 4889.3 4903.6 4908.0 4919.5 4694.9 4744.5 4827.9 4870.0 4892.4 4651.3 4672.1 4710.3 4758.5 4824.8 4793.5 4876.6 4899.8 4911.5 4915.6 4525.3 4629.4 4651.7 4811.6 4867.0 06:09:52 INFO - 2015-11-13 06:09:52,993 DEBUG : BROWSER_OUTPUT: 06:09:52 INFO - 2015-11-13 06:09:52,993 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42622.31 Median:32302.26 stddev:73631.94 (227.9%) stddev-sans-first:73770.47 06:09:52 INFO - 2015-11-13 06:09:52,995 DEBUG : BROWSER_OUTPUT: Values: 466.7 488.8 504.4 510.1 513.8 27090.9 27630.7 27704.4 27807.3 28032.0 37238.8 37587.8 37703.4 37768.2 38191.0 8101.8 8157.1 8274.5 8336.6 8347.6 8022.7 8196.8 8216.1 8224.3 8224.8 7999.7 8130.1 8143.7 8184.0 8217.3 8112.6 8182.1 8200.8 8252.8 8306.9 7882.3 8019.9 8021.4 8095.6 8117.5 34214.3 34680.5 34802.6 35125.3 35287.3 2162.9 2303.6 2346.8 2600.5 2679.0 25669.4 26695.7 26866.2 27131.5 27959.0 2110.0 2157.2 2166.5 2172.2 2175.5 225388.0 227185.0 229234.0 229970.0 231655.0 43971.8 52677.2 52848.7 53545.5 53946.2 43341.0 54666.2 55687.0 56675.4 56746.0 14195.7 14702.6 14706.9 14780.6 14785.8 10955.4 11074.2 11107.3 11118.7 11242.3 17728.2 18181.7 18193.8 18252.9 18316.5 7544.8 7780.6 7796.4 7874.4 7920.2 845.1 847.9 856.6 932.4 967.6 25680.0 26539.5 27017.5 27062.0 27125.9 926.8 941.1 985.7 1009.1 1044.9 12416.4 13203.5 13768.4 14080.2 14160.1 338682.0 345903.0 346911.0 349951.0 350729.0 49321.8 50035.0 50202.5 50203.7 50771.0 1204.9 1226.1 1226.5 1232.9 1236.6 25372.0 25522.5 25837.5 26017.7 26105.0 40722.6 40862.6 40923.2 41337.6 41338.2 247177.0 251178.0 253810.0 254618.0 254977.0 27050.9 38057.6 40411.4 40766.8 40895.0 36519.1 36883.3 37277.4 37287.9 37935.2 30332.8 31820.8 31864.0 31959.0 32127.5 30476.0 30840.4 30953.7 30998.5 34252.0 31021.5 31131.0 31399.4 31641.2 32477.0 25922.5 26213.6 28358.4 28428.4 28642.9 20441.8 20446.4 20490.6 20654.9 20681.3 06:09:52 INFO - 2015-11-13 06:09:52,995 DEBUG : BROWSER_OUTPUT: 06:09:52 INFO - 2015-11-13 06:09:52,995 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24586.74 Median:4717.69 stddev:86212.05 (1827.4%) stddev-sans-first:86434.59 06:09:52 INFO - 2015-11-13 06:09:52,996 DEBUG : BROWSER_OUTPUT: Values: 288.7 288.7 290.8 292.4 298.6 8722.8 8874.0 14811.9 14907.5 15526.5 9888.7 10015.7 10239.9 10241.5 10352.4 3829.6 3936.5 3947.0 3968.3 3978.7 2970.2 2992.7 3959.3 4130.0 4258.3 4162.2 4233.1 4239.2 4243.9 4247.1 4070.2 4174.1 4179.4 4231.2 4242.3 3552.6 3554.6 3557.6 3586.1 3606.0 11404.9 11557.7 11679.6 11707.5 11763.6 1655.6 1668.6 1676.4 1681.6 1708.8 8050.4 8201.0 8245.3 8291.8 8464.7 1311.5 1343.1 1365.0 1381.9 1416.4 50465.7 52392.2 52539.9 52617.2 53062.7 5438.2 5534.4 5544.9 5627.2 5667.0 6365.4 6381.5 6411.7 6457.1 6463.1 4624.3 4708.8 4719.2 4731.5 4735.5 4684.7 4697.7 4716.2 4818.7 5036.6 2484.6 2506.5 2517.1 2528.7 2545.7 886.4 891.6 893.8 919.4 950.8 352.9 365.6 393.9 396.7 399.5 9360.4 9879.5 9915.0 9925.5 9947.8 387.6 390.5 391.8 394.9 418.1 5289.4 5348.5 5388.1 5457.4 5546.0 496723.0 509066.0 537759.0 541767.0 544732.0 63979.0 64183.0 64241.7 65247.0 66309.7 422.3 427.3 429.1 429.9 431.8 9313.4 9399.9 9417.8 9631.2 9660.3 29801.3 30762.0 31006.8 31553.2 31651.0 37094.0 38189.0 38574.0 39231.2 42890.8 5208.5 5287.3 5389.9 5424.4 5453.2 9517.5 10155.1 10173.7 10180.3 10334.2 8297.6 8484.7 8573.0 8744.7 8776.6 8519.5 8606.7 8647.1 8678.7 8809.3 8614.7 8795.4 8944.6 8982.1 9019.1 4943.7 5395.3 5424.6 5473.4 5516.3 8589.3 8625.7 8697.6 8961.3 9062.8 06:09:52 INFO - 2015-11-13 06:09:52,996 DEBUG : BROWSER_OUTPUT: 06:09:52 INFO - 2015-11-13 06:09:52,996 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4746.25 Median:6039.41 stddev:2472.94 (40.9%) stddev-sans-first:2465.82 06:09:52 INFO - 2015-11-13 06:09:52,997 DEBUG : BROWSER_OUTPUT: Values: 1239.1 1247.8 1274.5 1546.8 1626.5 5868.6 6300.3 6662.4 7192.1 7206.9 6563.7 6753.0 6820.8 6848.6 6874.4 1871.9 1901.1 1901.3 1907.3 1909.4 1889.0 1904.7 1913.2 1947.4 1953.6 1872.7 1895.9 1899.3 1899.5 1903.6 1850.4 1866.0 1869.8 1870.9 1877.8 1877.1 1914.0 1921.5 1933.3 1941.4 6888.8 6941.5 6951.6 6973.8 6977.9 4003.8 4067.6 4093.0 4107.5 4153.6 2515.1 2552.2 2572.2 2574.0 2683.9 808.3 816.9 836.2 843.3 845.9 9153.8 9167.4 9191.1 9194.4 9216.3 3604.2 3625.1 3654.2 3656.3 3660.3 8030.8 8044.9 8078.2 8086.9 8127.3 4149.8 4162.9 4185.4 4191.7 4231.0 3312.4 3384.0 3775.2 3789.1 3798.4 3106.3 3187.3 3198.6 3205.9 3226.9 1006.7 1028.5 1035.3 1041.1 1047.6 920.0 963.6 974.7 1173.3 1179.0 6340.2 6370.0 6387.2 6398.9 6425.5 992.9 1013.0 1025.5 1038.5 1040.7 4867.3 5041.3 5061.1 5063.1 5064.7 8014.6 8105.5 8275.2 8282.9 8287.5 8079.1 8131.6 8147.9 8200.9 8241.5 6440.9 6457.0 6475.7 6501.7 6505.7 6074.2 6181.0 6237.0 6260.3 6264.7 6787.6 7207.1 7213.5 7217.1 7292.6 7200.0 7380.9 7389.9 7404.0 7471.4 5403.6 5524.7 6026.5 6104.6 6127.8 6332.7 6520.4 6528.6 6572.8 6617.1 6076.3 6130.7 6163.0 6208.1 6246.3 6008.9 6052.3 6091.9 6134.7 6186.6 6163.4 6192.9 6226.4 6235.2 6298.4 5632.3 5656.3 5675.0 5701.3 5716.5 5484.4 5710.9 5727.6 5745.5 5750.4 06:09:52 INFO - 2015-11-13 06:09:52,997 DEBUG : BROWSER_OUTPUT: 06:09:52 INFO - 2015-11-13 06:09:52,997 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4843.74 Median:5623.23 stddev:1493.63 (26.6%) stddev-sans-first:1457.71 06:09:52 INFO - 2015-11-13 06:09:52,999 DEBUG : BROWSER_OUTPUT: Values: 262.9 265.0 269.8 279.1 286.3 5429.5 5439.7 5513.5 5616.2 5630.2 5537.8 5670.9 5681.5 5682.6 5709.1 4319.2 4354.0 4354.2 4374.8 4379.8 4329.7 4336.4 4357.8 4359.1 4375.4 4181.9 4294.2 4297.1 4319.2 4348.9 4238.6 4272.4 4287.8 4298.2 4328.5 3689.8 3701.3 3703.4 3705.2 3714.3 5426.6 5455.0 5471.3 5528.8 5537.7 4504.1 4596.4 4743.6 4745.2 4792.6 5637.3 5721.6 5731.9 5756.1 5763.6 3814.3 3817.7 3823.8 3825.2 3876.4 5991.4 6098.8 6100.6 6116.0 6128.2 3752.6 3898.9 3902.6 3910.4 3919.7 3984.1 3993.6 4002.7 4012.9 4041.8 4656.8 4659.5 4669.2 4670.9 4695.4 5802.5 5809.5 5810.7 5888.7 5903.0 1341.3 1371.7 1385.1 1386.9 1396.5 884.9 885.0 890.8 890.9 892.6 5460.4 5479.3 5482.5 5486.2 5536.7 6019.2 6029.6 6047.5 6054.6 6062.7 5400.5 5422.5 5430.2 5439.6 5452.6 3129.4 3206.6 3229.8 3238.3 3249.1 6063.4 6112.5 6146.3 6148.8 6157.1 6112.8 6116.9 6147.1 6147.3 6156.3 6069.0 6099.1 6109.4 6111.6 6118.9 5993.3 6002.8 6036.3 6054.5 6073.7 5744.8 5910.9 5923.5 5925.2 5932.1 6185.1 6185.8 6190.8 6207.1 6271.4 3721.8 3733.7 3784.2 3812.1 3823.9 5793.8 5984.9 6012.0 6022.2 6022.7 5703.3 5733.5 5877.8 5903.4 5915.0 5844.6 5883.7 5889.7 5932.3 5951.6 5567.9 5720.8 5758.7 5771.8 5776.8 5809.7 5879.1 5899.5 5904.0 5931.4 5699.3 5729.5 5745.5 5752.9 5758.6 06:09:52 INFO - 2015-11-13 06:09:52,999 DEBUG : BROWSER_OUTPUT: 06:09:52 INFO - 2015-11-13 06:09:52,999 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11545.91 Median:53287.73 stddev:14095.79 (26.5%) stddev-sans-first:14111.25 06:09:53 INFO - 2015-11-13 06:09:53,000 DEBUG : BROWSER_OUTPUT: Values: 574.3 606.9 649.8 655.8 657.3 11262.1 11606.0 11662.8 11671.8 11948.6 11220.2 11222.0 11238.4 11247.3 11289.6 773.3 786.5 790.1 791.1 798.0 601.8 618.2 771.8 801.4 814.0 824.8 835.7 845.9 847.0 848.6 835.3 835.8 836.1 837.6 853.6 619.9 620.3 623.5 627.0 627.5 11671.9 11796.8 11819.8 11836.2 12068.1 8065.4 8307.1 8544.8 9899.6 10284.9 7728.9 7840.2 7877.5 8058.3 8409.2 2645.6 2652.0 2658.0 2668.3 2676.4 37615.0 38050.8 38104.8 38124.8 38330.0 5764.3 5864.4 5898.3 5900.8 6141.0 10312.3 10334.5 10335.1 10345.5 10384.6 5150.3 5222.4 5306.0 5411.2 5435.9 3151.0 3151.6 3204.5 3223.8 3270.0 2445.5 2464.7 2471.3 2479.6 2487.0 350.8 360.7 368.1 369.1 370.9 411.3 463.8 494.9 496.4 509.1 6645.0 6716.5 6812.6 6813.5 6991.5 355.6 377.6 476.9 498.3 516.8 3236.6 3240.5 3269.0 3288.3 3364.9 51956.0 52611.2 52994.7 53142.7 53432.7 43050.4 43160.4 43329.8 43480.6 43883.8 39597.8 41346.4 41534.2 42307.4 44718.0 7211.2 7247.2 7259.5 7485.1 7489.7 31476.5 31679.7 31694.7 31829.4 32452.7 37887.0 38133.4 40790.7 41085.6 41369.4 9130.5 9424.2 9498.5 9748.1 9960.8 9432.5 9965.1 10170.5 10282.7 10561.3 9038.1 9099.4 9164.0 9482.5 9772.2 9121.1 9141.3 9190.5 9300.0 9928.9 8897.4 9134.8 9145.7 9203.2 9453.1 7674.5 7685.4 7801.6 7997.4 8859.2 7472.8 7483.0 7517.2 7565.0 8056.7 06:09:53 INFO - 2015-11-13 06:09:53,000 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:09:53 INFO - 2015-11-13 06:09:53,000 DEBUG : BROWSER_OUTPUT: 06:09:53 INFO - 2015-11-13 06:09:53,672 INFO : Browser exited with error code: 0 06:09:53 INFO - 2015-11-13 06:09:53,702 INFO : Completed test dromaeo_css (00:18:33) 06:09:53 INFO - 2015-11-13 06:09:53,702 INFO : Starting test kraken 06:09:53 INFO - 2015-11-13 06:09:53,702 DEBUG : operating with platform_type : mac_ 06:09:53 INFO - 2015-11-13 06:09:53,703 INFO : Initialising browser for kraken test... 06:09:53 INFO - 2015-11-13 06:09:53,717 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/tmp3fttsA/profile http://localhost:49264/getInfo.html 06:09:56 INFO - 2015-11-13 06:09:56,859 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:09:56 INFO - 2015-11-13 06:09:56,859 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:09:56 INFO - 2015-11-13 06:09:56,859 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:09:56 INFO - 2015-11-13 06:09:56,860 DEBUG : BROWSER_OUTPUT: __metrics 06:09:57 INFO - 2015-11-13 06:09:57,581 INFO : Browser initialized. 06:09:57 INFO - 2015-11-13 06:09:57,582 INFO : Running cycle 1/1 for kraken test... 06:09:57 INFO - 2015-11-13 06:09:57,582 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/tmp3fttsA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:10:09 INFO - 2015-11-13 06:10:09,739 DEBUG : BROWSER_OUTPUT: RSS: Main: 240320512 06:10:09 INFO - 2015-11-13 06:10:09,740 DEBUG : BROWSER_OUTPUT: 06:10:12 INFO - 2015-11-13 06:10:12,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection) 06:10:13 INFO - 2015-11-13 06:10:13,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 259497984 06:10:13 INFO - 2015-11-13 06:10:13,144 DEBUG : BROWSER_OUTPUT: 06:10:16 INFO - 2015-11-13 06:10:16,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-dft) 06:10:16 INFO - 2015-11-13 06:10:16,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 267599872 06:10:16 INFO - 2015-11-13 06:10:16,697 DEBUG : BROWSER_OUTPUT: 06:10:19 INFO - 2015-11-13 06:10:19,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-fft) 06:10:20 INFO - 2015-11-13 06:10:20,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 268275712 06:10:20 INFO - 2015-11-13 06:10:20,513 DEBUG : BROWSER_OUTPUT: 06:10:22 INFO - 2015-11-13 06:10:22,734 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator) 06:10:23 INFO - 2015-11-13 06:10:23,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 267591680 06:10:23 INFO - 2015-11-13 06:10:23,326 DEBUG : BROWSER_OUTPUT: 06:10:25 INFO - 2015-11-13 06:10:25,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:10:26 INFO - 2015-11-13 06:10:26,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 268480512 06:10:26 INFO - 2015-11-13 06:10:26,275 DEBUG : BROWSER_OUTPUT: 06:10:29 INFO - 2015-11-13 06:10:29,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom) 06:10:30 INFO - 2015-11-13 06:10:30,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 268857344 06:10:30 INFO - 2015-11-13 06:10:30,303 DEBUG : BROWSER_OUTPUT: 06:10:33 INFO - 2015-11-13 06:10:33,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate) 06:10:34 INFO - 2015-11-13 06:10:34,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 267558912 06:10:34 INFO - 2015-11-13 06:10:34,433 DEBUG : BROWSER_OUTPUT: 06:10:37 INFO - 2015-11-13 06:10:37,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial) 06:10:38 INFO - 2015-11-13 06:10:38,242 DEBUG : BROWSER_OUTPUT: RSS: Main: 268300288 06:10:38 INFO - 2015-11-13 06:10:38,242 DEBUG : BROWSER_OUTPUT: 06:10:39 INFO - 2015-11-13 06:10:39,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:10:40 INFO - 2015-11-13 06:10:40,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 267182080 06:10:40 INFO - 2015-11-13 06:10:40,531 DEBUG : BROWSER_OUTPUT: 06:10:42 INFO - 2015-11-13 06:10:42,487 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:10:43 INFO - 2015-11-13 06:10:43,111 DEBUG : BROWSER_OUTPUT: RSS: Main: 267706368 06:10:43 INFO - 2015-11-13 06:10:43,111 DEBUG : BROWSER_OUTPUT: 06:10:45 INFO - 2015-11-13 06:10:45,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:10:46 INFO - 2015-11-13 06:10:46,049 DEBUG : BROWSER_OUTPUT: RSS: Main: 267763712 06:10:46 INFO - 2015-11-13 06:10:46,050 DEBUG : BROWSER_OUTPUT: 06:10:48 INFO - 2015-11-13 06:10:48,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:10:49 INFO - 2015-11-13 06:10:49,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 268013568 06:10:49 INFO - 2015-11-13 06:10:49,541 DEBUG : BROWSER_OUTPUT: 06:10:52 INFO - 2015-11-13 06:10:52,492 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:10:53 INFO - 2015-11-13 06:10:53,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 266850304 06:10:53 INFO - 2015-11-13 06:10:53,077 DEBUG : BROWSER_OUTPUT: 06:10:54 INFO - 2015-11-13 06:10:54,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49264/tests/kraken/driver.html?testName=ai-astar) 06:10:55 INFO - 2015-11-13 06:10:55,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 269160448 06:10:55 INFO - 2015-11-13 06:10:55,200 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,201 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:10:55 INFO - 2015-11-13 06:10:55,201 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:10:55 INFO - 2015-11-13 06:10:55,201 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:10:55 INFO - 2015-11-13 06:10:55,201 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:10:55 INFO - 2015-11-13 06:10:55,201 DEBUG : BROWSER_OUTPUT: |0;ai-astar;122;118;135;134;129;138;132;128;135;135 06:10:55 INFO - 2015-11-13 06:10:55,202 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;170;162;181;192;157;179;177;150;193;157 06:10:55 INFO - 2015-11-13 06:10:55,202 DEBUG : BROWSER_OUTPUT: |2;audio-dft;188;200;205;204;202;198;193;193;196;204 06:10:55 INFO - 2015-11-13 06:10:55,202 DEBUG : BROWSER_OUTPUT: |3;audio-fft;84;84;94;138;82;80;84;89;144;81 06:10:55 INFO - 2015-11-13 06:10:55,202 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;101;105;156;106;110;111;151;104;105;150 06:10:55 INFO - 2015-11-13 06:10:55,202 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;142;147;136;142;143;149;145;142;143 06:10:55 INFO - 2015-11-13 06:10:55,202 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;157;157;154;151;150;157;157;155;150;157 06:10:55 INFO - 2015-11-13 06:10:55,202 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;122;118;122;125;130;117;118;117;128;122 06:10:55 INFO - 2015-11-13 06:10:55,202 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;67;72;74;74;74;76;77;78;77;78 06:10:55 INFO - 2015-11-13 06:10:55,202 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;74;78;78;82;80;82;81;79;78;79 06:10:55 INFO - 2015-11-13 06:10:55,203 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;98;101;106;106;105;107;107;102;112;119 06:10:55 INFO - 2015-11-13 06:10:55,203 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;152;164;150;156;156;153;163;153;157;156 06:10:55 INFO - 2015-11-13 06:10:55,203 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;170;186;184;190;192;172;184;184;184;191 06:10:55 INFO - 2015-11-13 06:10:55,203 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;78;83;90;87;88;89;88;88;89;84 06:10:55 INFO - 2015-11-13 06:10:55,203 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:10:55 INFO - 2015-11-13 06:10:55,203 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:10:55 INFO - 2015-11-13 06:10:55,203 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,736 06:10:55 INFO - 2015-11-13 06:10:55,203 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:10:55 INFO - 2015-11-13 06:10:55,203 DEBUG : BROWSER_OUTPUT: __startTimestamp1447423855199__endTimestamp 06:10:55 INFO - 2015-11-13 06:10:55,203 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,205 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:10:55 INFO - 2015-11-13 06:10:55,205 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:10:55 INFO - 2015-11-13 06:10:55,205 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,205 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:130.60 Median:134.50 stddev:6.40 (4.8%) stddev-sans-first:5.98 06:10:55 INFO - 2015-11-13 06:10:55,206 DEBUG : BROWSER_OUTPUT: Values: 122.0 118.0 135.0 134.0 129.0 138.0 132.0 128.0 135.0 135.0 06:10:55 INFO - 2015-11-13 06:10:55,206 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,206 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:171.80 Median:178.00 stddev:15.03 (8.4%) stddev-sans-first:15.93 06:10:55 INFO - 2015-11-13 06:10:55,206 DEBUG : BROWSER_OUTPUT: Values: 170.0 162.0 181.0 192.0 157.0 179.0 177.0 150.0 193.0 157.0 06:10:55 INFO - 2015-11-13 06:10:55,206 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,206 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:198.30 Median:201.00 stddev:5.72 (2.8%) stddev-sans-first:4.69 06:10:55 INFO - 2015-11-13 06:10:55,207 DEBUG : BROWSER_OUTPUT: Values: 188.0 200.0 205.0 204.0 202.0 198.0 193.0 193.0 196.0 204.0 06:10:55 INFO - 2015-11-13 06:10:55,207 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,207 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:96.00 Median:84.00 stddev:24.11 (28.7%) stddev-sans-first:25.17 06:10:55 INFO - 2015-11-13 06:10:55,207 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 94.0 138.0 82.0 80.0 84.0 89.0 144.0 81.0 06:10:55 INFO - 2015-11-13 06:10:55,207 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,207 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:119.90 Median:110.50 stddev:22.61 (20.5%) stddev-sans-first:22.92 06:10:55 INFO - 2015-11-13 06:10:55,207 DEBUG : BROWSER_OUTPUT: Values: 101.0 105.0 156.0 106.0 110.0 111.0 151.0 104.0 105.0 150.0 06:10:55 INFO - 2015-11-13 06:10:55,208 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,208 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:143.10 Median:143.00 stddev:3.48 (2.4%) stddev-sans-first:3.67 06:10:55 INFO - 2015-11-13 06:10:55,208 DEBUG : BROWSER_OUTPUT: Values: 142.0 142.0 147.0 136.0 142.0 143.0 149.0 145.0 142.0 143.0 06:10:55 INFO - 2015-11-13 06:10:55,209 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,209 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:154.50 Median:157.00 stddev:3.06 (2.0%) stddev-sans-first:3.11 06:10:55 INFO - 2015-11-13 06:10:55,210 DEBUG : BROWSER_OUTPUT: Values: 157.0 157.0 154.0 151.0 150.0 157.0 157.0 155.0 150.0 157.0 06:10:55 INFO - 2015-11-13 06:10:55,210 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,210 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:121.90 Median:122.00 stddev:4.61 (3.8%) stddev-sans-first:4.88 06:10:55 INFO - 2015-11-13 06:10:55,210 DEBUG : BROWSER_OUTPUT: Values: 122.0 118.0 122.0 125.0 130.0 117.0 118.0 117.0 128.0 122.0 06:10:55 INFO - 2015-11-13 06:10:55,210 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,210 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.70 Median:76.50 stddev:3.37 (4.4%) stddev-sans-first:2.13 06:10:55 INFO - 2015-11-13 06:10:55,211 DEBUG : BROWSER_OUTPUT: Values: 67.0 72.0 74.0 74.0 74.0 76.0 77.0 78.0 77.0 78.0 06:10:55 INFO - 2015-11-13 06:10:55,211 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,211 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:79.10 Median:79.50 stddev:2.38 (3.0%) stddev-sans-first:1.66 06:10:55 INFO - 2015-11-13 06:10:55,211 DEBUG : BROWSER_OUTPUT: Values: 74.0 78.0 78.0 82.0 80.0 82.0 81.0 79.0 78.0 79.0 06:10:55 INFO - 2015-11-13 06:10:55,211 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,211 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:106.30 Median:107.00 stddev:5.89 (5.5%) stddev-sans-first:5.43 06:10:55 INFO - 2015-11-13 06:10:55,212 DEBUG : BROWSER_OUTPUT: Values: 98.0 101.0 106.0 106.0 105.0 107.0 107.0 102.0 112.0 119.0 06:10:55 INFO - 2015-11-13 06:10:55,212 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,212 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:156.00 Median:156.00 stddev:4.52 (2.9%) stddev-sans-first:4.56 06:10:55 INFO - 2015-11-13 06:10:55,212 DEBUG : BROWSER_OUTPUT: Values: 152.0 164.0 150.0 156.0 156.0 153.0 163.0 153.0 157.0 156.0 06:10:55 INFO - 2015-11-13 06:10:55,212 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,214 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.70 Median:185.00 stddev:7.39 (4.0%) stddev-sans-first:5.95 06:10:55 INFO - 2015-11-13 06:10:55,214 DEBUG : BROWSER_OUTPUT: Values: 170.0 186.0 184.0 190.0 192.0 172.0 184.0 184.0 184.0 191.0 06:10:55 INFO - 2015-11-13 06:10:55,214 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,214 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.40 Median:88.00 stddev:3.69 (4.2%) stddev-sans-first:2.35 06:10:55 INFO - 2015-11-13 06:10:55,214 DEBUG : BROWSER_OUTPUT: Values: 78.0 83.0 90.0 87.0 88.0 89.0 88.0 88.0 89.0 84.0 06:10:55 INFO - 2015-11-13 06:10:55,215 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:10:55 INFO - 2015-11-13 06:10:55,215 DEBUG : BROWSER_OUTPUT: 06:10:55 INFO - 2015-11-13 06:10:55,938 INFO : Browser exited with error code: 0 06:10:55 INFO - 2015-11-13 06:10:55,991 INFO : Completed test kraken (00:01:02) 06:10:55 INFO - 2015-11-13 06:10:55,991 INFO : Starting test v8_7 06:10:55 INFO - 2015-11-13 06:10:55,991 DEBUG : operating with platform_type : mac_ 06:10:55 INFO - 2015-11-13 06:10:55,992 INFO : Initialising browser for v8_7 test... 06:10:56 INFO - 2015-11-13 06:10:56,006 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/tmpNO7tqg/profile http://localhost:49264/getInfo.html 06:10:59 INFO - 2015-11-13 06:10:59,115 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:10:59 INFO - 2015-11-13 06:10:59,115 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:10:59 INFO - 2015-11-13 06:10:59,115 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 06:10:59 INFO - 2015-11-13 06:10:59,115 DEBUG : BROWSER_OUTPUT: __metrics 06:10:59 INFO - 2015-11-13 06:10:59,788 INFO : Browser initialized. 06:10:59 INFO - 2015-11-13 06:10:59,789 INFO : Running cycle 1/1 for v8_7 test... 06:10:59 INFO - 2015-11-13 06:10:59,789 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/tmpNO7tqg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:11:11 INFO - 2015-11-13 06:11:11,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 241418240 06:11:11 INFO - 2015-11-13 06:11:11,905 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49264/tests/v8_7/run.html (next: http://localhost:49264/tests/v8_7/run.html) 06:11:34 INFO - 2015-11-13 06:11:34,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 261607424 06:11:34 INFO - 2015-11-13 06:11:34,819 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,819 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:11:34 INFO - 2015-11-13 06:11:34,819 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:11:34 INFO - 2015-11-13 06:11:34,819 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:11:34 INFO - 2015-11-13 06:11:34,819 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:11:34 INFO - 2015-11-13 06:11:34,819 DEBUG : BROWSER_OUTPUT: |0;Richards;877.1929824561404 06:11:34 INFO - 2015-11-13 06:11:34,819 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;227.22108611679164 06:11:34 INFO - 2015-11-13 06:11:34,819 DEBUG : BROWSER_OUTPUT: |2;Encrypt;363.7686431429611 06:11:34 INFO - 2015-11-13 06:11:34,819 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6605.263157894737 06:11:34 INFO - 2015-11-13 06:11:34,819 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1298.7012987012988 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: |5;Earley;904.9773755656108 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: |6;Boyer;15303.030303030304 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: |7;RegExp;33112.903225806454 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: |8;Splay;745.156482861401 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6575.16339869281 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: __startTimestamp1447423894809__endTimestamp 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:877.19 Median:877.19 stddev:0.00 (0.0%) 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: Values: 877.2 06:11:34 INFO - 2015-11-13 06:11:34,820 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,821 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:227.22 Median:227.22 stddev:0.00 (0.0%) 06:11:34 INFO - 2015-11-13 06:11:34,821 DEBUG : BROWSER_OUTPUT: Values: 227.2 06:11:34 INFO - 2015-11-13 06:11:34,821 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,821 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:363.77 Median:363.77 stddev:0.00 (0.0%) 06:11:34 INFO - 2015-11-13 06:11:34,821 DEBUG : BROWSER_OUTPUT: Values: 363.8 06:11:34 INFO - 2015-11-13 06:11:34,821 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,821 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6605.26 Median:6605.26 stddev:0.00 (0.0%) 06:11:34 INFO - 2015-11-13 06:11:34,821 DEBUG : BROWSER_OUTPUT: Values: 6605.3 06:11:34 INFO - 2015-11-13 06:11:34,821 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,821 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1298.70 Median:1298.70 stddev:0.00 (0.0%) 06:11:34 INFO - 2015-11-13 06:11:34,821 DEBUG : BROWSER_OUTPUT: Values: 1298.7 06:11:34 INFO - 2015-11-13 06:11:34,822 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,822 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:904.98 Median:904.98 stddev:0.00 (0.0%) 06:11:34 INFO - 2015-11-13 06:11:34,822 DEBUG : BROWSER_OUTPUT: Values: 905.0 06:11:34 INFO - 2015-11-13 06:11:34,822 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,822 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15303.03 Median:15303.03 stddev:0.00 (0.0%) 06:11:34 INFO - 2015-11-13 06:11:34,822 DEBUG : BROWSER_OUTPUT: Values: 15303.0 06:11:34 INFO - 2015-11-13 06:11:34,822 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,822 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33112.90 Median:33112.90 stddev:0.00 (0.0%) 06:11:34 INFO - 2015-11-13 06:11:34,822 DEBUG : BROWSER_OUTPUT: Values: 33112.9 06:11:34 INFO - 2015-11-13 06:11:34,822 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,822 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:745.16 Median:745.16 stddev:0.00 (0.0%) 06:11:34 INFO - 2015-11-13 06:11:34,823 DEBUG : BROWSER_OUTPUT: Values: 745.2 06:11:34 INFO - 2015-11-13 06:11:34,823 DEBUG : BROWSER_OUTPUT: 06:11:34 INFO - 2015-11-13 06:11:34,823 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6575.16 Median:6575.16 stddev:0.00 (0.0%) 06:11:34 INFO - 2015-11-13 06:11:34,823 DEBUG : BROWSER_OUTPUT: Values: 6575.2 06:11:34 INFO - 2015-11-13 06:11:34,823 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:11:34 INFO - 2015-11-13 06:11:34,823 DEBUG : BROWSER_OUTPUT: 06:11:35 INFO - 2015-11-13 06:11:35,530 INFO : Browser exited with error code: 0 06:11:35 INFO - 2015-11-13 06:11:35,552 INFO : Completed test v8_7 (00:00:39) 06:11:35 INFO - 2015-11-13 06:11:35,726 INFO : Completed test suite (00:20:15) 06:11:35 INFO - 2015-11-13 06:11:35,726 DEBUG : Working with test: dromaeo_css 06:11:35 INFO - 2015-11-13 06:11:35,726 DEBUG : Generating results file: dromaeo_css 06:11:35 INFO - 2015-11-13 06:11:35,727 DEBUG : Working with test: kraken 06:11:35 INFO - 2015-11-13 06:11:35,727 DEBUG : Generating results file: kraken 06:11:35 INFO - 2015-11-13 06:11:35,727 INFO : javascript benchmark 06:11:35 INFO - 2015-11-13 06:11:35,727 DEBUG : Working with test: v8_7 06:11:35 INFO - 2015-11-13 06:11:35,727 DEBUG : Generating results file: v8_7 06:11:35 INFO - 2015-11-13 06:11:35,728 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:11:35 INFO - 2015-11-13 06:11:35,800 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 06:11:35 INFO - 2015-11-13 06:11:35,800 DEBUG : process_Request line: dromaeo_css 5780.77 graph.html#tests=[[72,64,57]] 06:11:35 INFO - 2015-11-13 06:11:35,800 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:11:35 INFO - 2015-11-13 06:11:35,834 DEBUG : process_Request line: kraken 1822.30 graph.html#tests=[[232,64,57]] 06:11:35 INFO - 2015-11-13 06:11:35,834 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:11:35 INFO - 2015-11-13 06:11:35,889 DEBUG : process_Request line: v8_7 14650.09 graph.html#tests=[[230,64,57]] 06:11:35 INFO - 2015-11-13 06:11:35,890 INFO : javascript benchmark 06:11:35 INFO - 2015-11-13 06:11:35,892 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [288.7011942639369, 288.7040783197224, 290.78191356482637, 292.36410806495877, 298.6073313592625, 8722.825543489127, 8873.95563022184, 14811.851881481181, 14907.478238261663, 15526.456574019898, 9888.703338899844, 10015.69952901414, 10239.948800256007, 10241.539130739116, 10352.37885726857, 3829.636184562462, 3936.5472970608316, 3946.980265098685, 3968.30554652936, 3978.7214894957365, 2970.2425881400213, 2992.685767994362, 3959.346707793225, 4129.979350103245, 4258.254805409041, 4162.1675664867, 4233.068724880522, 4239.152169566084, 4243.915121697564, 4247.065645557972, 4070.1656160487028, 4174.102567947891, 4179.435776170239, 4231.196072746184, 4242.3212286034395, 3552.6447355264268, 3554.573451185848, 3557.573091229069, 3586.0855481852223, 3606.04439823447, 11404.94297528507, 11557.653270401901, 11679.649610511698, 11707.53169873204, 11763.647090587296, 1655.6192075822507, 1668.6329007618303, 1676.4132553606262, 1681.5711993441716, 1708.8205738397414, 8050.4364694471415, 8200.958995205045, 8245.340372770164, 8291.83416331676, 8464.66141354345, 1311.5081844308384, 1343.0799902067017, 1364.986350136496, 1381.896357773161, 1416.419268100074, 50465.74767126141, 52392.21411678828, 52539.94920101615, 52617.210741838906, 53062.73468632671, 5438.15708565173, 5534.446555344514, 5544.944550554524, 5627.155926610959, 5666.97166514173, 6365.36346365369, 6381.521385896076, 6411.711472983727, 6457.063725759738, 6463.095166676669, 4624.306354046853, 4708.764561771898, 4719.221328480762, 4731.503192164842, 4735.502772208937, 4684.718916864999, 4697.718136911728, 4716.151092803259, 4818.71087734737, 5036.622253331015, 2484.59004264298, 2506.511230310072, 2517.1315896015844, 2528.7091984422027, 2545.707243667002, 886.3928209176735, 891.6032365597247, 893.7988952485639, 919.4483310014072, 950.8431108867098, 352.9446953608743, 365.56315203331764, 393.9054626889583, 396.7363945832533, 399.53172092559726, 9360.391574547633, 9879.506024698736, 9914.950425247971, 9925.503724813874, 9947.80104397908, 387.56399051067547, 390.4670125278974, 391.8256375912691, 394.91509325495156, 418.11359916976204, 5289.3917199521775, 5348.518633322942, 5388.084025715638, 5457.426970168075, 5545.972270138624, 496723.0, 509066.0, 537759.0, 541767.0, 544732.0, 63979.0, 64183.0, 64241.678791606675, 65247.0, 66309.66845165743, 422.3306059895039, 427.31842710876106, 429.06677975403375, 429.91401719656193, 431.7905815679393, 9313.39462934907, 9399.859002114837, 9417.811643767223, 9631.181349585364, 9660.3237773358, 29801.25496862596, 30762.0, 31006.84496577593, 31553.211169720023, 31651.0, 37094.0, 38189.0, 38574.0, 39231.2153756929, 42890.78554607207, 5208.53123218897, 5287.339082614673, 5389.865253368697, 5424.430434804446, 5453.209284653623, 9517.476538790434, 10155.136813370946, 10173.694789156338, 10180.287379883337, 10334.224933129895, 8297.58512074406, 8484.660613575388, 8572.957135214285, 8744.650213991368, 8776.648934042567, 8519.531425771394, 8606.65573377058, 8647.0920553341, 8678.652853885775, 8809.251213646912, 8614.655413783628, 8795.428297160664, 8944.642214311614, 8982.146696063863, 9019.143181397756, 4943.703377797344, 5395.271638328933, 5424.647397919122, 5473.397926228191, 5516.310461192351, 8589.312854971462, 8625.654973800978, 8697.6086076128, 8961.283097352065, 9062.773430664287], "dojo.html": [2708.34999600096, 2724.6594175728032, 2784.749372556468, 2790.135058131978, 2797.81814182078, 4601.378813860128, 4625.4911959684405, 4655.255159174532, 4685.67200295979, 4747.05058988202, 4441.356003379508, 4573.3368661544055, 4578.885527861797, 4620.653450991173, 4699.506551812062, 4265.488141423026, 4342.956570434302, 4350.869473915787, 4426.77866106695, 4480.798364073608, 4088.9386659200136, 4405.140997505488, 4459.799309031101, 4469.240229161034, 4543.886402839939, 4242.469691288589, 4305.31115021595, 4371.584699453579, 4377.190219809346, 4420.6242469390145, 4378.387025816388, 4412.580804823537, 4417.4919884213405, 4447.755373454459, 4474.082813023322, 4398.516163222043, 4417.690761646686, 4434.002349471375, 4465.017696106851, 4470.08363285529, 4351.977285337943, 4493.573110554492, 4573.0, 4591.012932219555, 4681.368015317957, 4863.489333619989, 4899.191633380488, 4964.180910149821, 4976.850694479172, 5004.674696144775, 5047.9495205048215, 5063.594912406998, 5068.518490743373, 5070.163423035195, 5099.133147364957, 4467.6425885929375, 4624.44506659203, 4633.953660463386, 4673.205555055649, 4750.097481478508, 5157.123289040872, 5177.948220517746, 5221.399539052982, 5230.215467679803, 5231.24146998683, 4682.719036857799, 4921.557059864558, 4933.58064564516, 4971.130052240844, 5040.798368065236, 4927.507249275044, 4967.90064198714, 5049.267856160836, 5059.392872855281, 5085.6948583084395, 4963.751812409365, 4965.255211718271, 4975.577075948585, 5005.72468514228, 5046.6719663221775, 4913.950860491421, 4969.602431805447, 4982.526659967298, 4996.050750357494, 5032.597392208614, 3814.6376094271, 3821.885343439701, 3885.8834234972996, 3917.196974620196, 3928.332183528807, 3496.493008513751, 3528.259065596202, 3536.487209354629, 3537.858485660596, 3558.466230065459, 4434.955650443519, 4523.84166554169, 4660.324252983299, 4715.363425937523, 4728.95271047292, 4836.395450568679, 4918.852434426902, 4925.7783399747095, 4930.161872481687, 4980.526849949321, 4669.906601867943, 4673.976630116896, 4687.554682305175, 4701.835435759732, 4704.15325241453, 4174.269502836992, 4279.7218180818145, 4388.9122217556105, 4425.114977004612, 4469.508354081048, 5010.173321401928, 5070.340855688737, 5073.720945347967, 5130.0, 5151.665141765773, 5030.974845125897, 5034.823781167642, 5040.243963405518, 5069.0, 5106.336176297058, 5015.097282489041, 5124.30821839047, 5166.044281807877, 5177.068127737043, 5228.6078544110105, 4903.730294833818, 4932.975335123445, 4938.1358262304675, 4944.0, 4976.353074100344, 4875.975620121877, 4876.561109500162, 4894.143524883202, 5001.64988450805, 5043.117454445384, 4793.712377257376, 4889.266610008527, 4903.632227583017, 4907.950920490749, 4919.4834542373965, 4694.859154225379, 4744.525547445228, 4827.927581086356, 4869.95130048695, 4892.363992681071, 4651.348811166507, 4672.065586882569, 4710.317004034464, 4758.452777930583, 4824.831130910401, 4793.520647935178, 4876.609871210224, 4899.755012249445, 4911.50884911506, 4915.557599816034, 4525.321201819754, 4629.421322334708, 4651.697639653412, 4811.591014763644, 4867.026594681149], "mootools.html": [1239.0706969772673, 1247.83154274173, 1274.5156840400646, 1546.7989161409007, 1626.5120463860853, 5868.559858010655, 6300.30696623371, 6662.433693136083, 7192.136943566773, 7206.8558628827395, 6563.7046332915015, 6752.966235168818, 6820.761273355433, 6848.623325717083, 6874.415674667647, 1871.8876867387967, 1901.0684764465382, 1901.306023301492, 1907.3229003703625, 1909.4367161687335, 1888.9905550472229, 1904.7047707605343, 1913.1677720191692, 1947.4449781812186, 1953.6190442863647, 1872.7378167056622, 1895.895725735084, 1899.3257393625272, 1899.4586542835295, 1903.6002439487725, 1850.3708739028727, 1865.990670046648, 1869.7849747279101, 1870.9064546772606, 1877.7934427212995, 1877.0896115384028, 1913.9712904306446, 1921.5484361175113, 1933.3136736458637, 1941.398166568354, 6888.793336199922, 6941.5140940134215, 6951.582905025664, 6973.825654358631, 6977.930220697779, 4003.7597744135446, 4067.572904845008, 4093.038136038029, 4107.527634322061, 4153.563875793058, 2515.1071369663687, 2552.221572420411, 2572.164046684835, 2573.961390579143, 2683.8658067096567, 808.3452403553141, 816.8897198878194, 836.1554829622065, 843.32665450522, 845.9154084591553, 9153.81692366149, 9167.404118732262, 9191.126842949909, 9194.35639505235, 9216.262698984065, 3604.243108947098, 3625.148090198801, 3654.1778099927305, 3656.2504686539196, 3660.3411385950253, 8030.839383212303, 8044.919550804534, 8078.192180781993, 8086.919130808734, 8127.3091787198755, 4149.813258403379, 4162.91674166515, 4185.351270553069, 4191.6856235781825, 4231.0, 3312.38720836646, 3384.035549868325, 3775.188334508094, 3789.1285004449132, 3798.3922572388838, 3106.3476669899123, 3187.282861356223, 3198.5841840561043, 3205.9038228853174, 3226.8547915343865, 1006.7332156978407, 1028.4651980969854, 1035.2649618770756, 1041.0786453988276, 1047.643801107627, 919.9540022998823, 963.633819148719, 974.741693451236, 1173.3487914207526, 1178.9941050294865, 6340.239171299474, 6370.044493325945, 6387.2335319761, 6398.936010639927, 6425.518086143465, 992.9205663546899, 1012.9746756331151, 1025.5436330832856, 1038.5222797513077, 1040.6669865643073, 4867.318575399447, 5041.344625198701, 5061.063703214917, 5063.139266324733, 5064.721440320818, 8014.639341229658, 8105.473144245723, 8275.213854683796, 8282.917170828214, 8287.544185069879, 8079.111297757242, 8131.5527645978855, 8147.877781833277, 8200.917990820135, 8241.546714930617, 6440.871182576416, 6457.0, 6475.7085931133215, 6501.739930402731, 6505.739770409131, 6074.210352654127, 6181.0, 6236.968815155895, 6260.280067792262, 6264.718087685974, 6787.626680532618, 7207.13514378278, 7213.458990575623, 7217.06178196831, 7292.635368231673, 7200.0, 7380.926190738024, 7389.926100738924, 7404.037475128199, 7471.402287816853, 5403.567714582902, 5524.723763811874, 6026.487748541248, 6104.633721976696, 6127.754889804358, 6332.746690132343, 6520.380563846427, 6528.608283503005, 6572.8356791080605, 6617.139771829631, 6076.270847498328, 6130.693465326805, 6163.0, 6208.068789681584, 6246.312905580292, 6008.909866351921, 6052.334243233329, 6091.908621370594, 6134.693265336805, 6186.628802271878, 6163.414475624809, 6192.938070619236, 6226.377362263737, 6235.158253635701, 6298.401651843067, 5632.2678051853, 5656.3495198051105, 5674.9785038693435, 5701.315842098975, 5716.456936591017, 5484.369297530676, 5710.885782284414, 5727.627704199213, 5745.454181852718, 5750.424957504216], "ext.html": [466.73862636923326, 488.8240233515934, 504.4224363104246, 510.0945821167428, 513.7533983687828, 27090.86454567727, 27630.723692763066, 27704.445911081766, 27807.304817379576, 28032.0, 37238.813805930935, 37587.81206093972, 37703.4344484833, 37768.24463510728, 38191.0, 8101.837963240731, 8157.102718700939, 8274.544900030496, 8336.62485188165, 8347.624356903923, 8022.719204827832, 8196.75409737706, 8216.055153657346, 8224.259816616503, 8224.753257402288, 7999.720009799658, 8130.146334634866, 8143.714969976052, 8184.0, 8217.342612591008, 8112.553809540473, 8182.099969003405, 8200.794980125485, 8252.752417427457, 8306.875396869053, 7882.251186137365, 8019.879701804478, 8021.398395120331, 8095.635696393676, 8117.512949223006, 34214.315713685835, 34680.479792803126, 34802.607895684145, 35125.29749405023, 35287.29425411503, 2162.91348346066, 2303.581569405947, 2346.8005219556358, 2600.479904019204, 2679.0355472030055, 25669.3582660435, 26695.73304266952, 26866.19401417941, 27131.45737085267, 27959.0, 2109.95780084399, 2157.1587081038406, 2166.534195148035, 2172.196287373682, 2175.4670105824016, 225388.0, 227185.0, 229234.0, 229970.0, 231655.0, 43971.78014109909, 52677.209841852404, 52848.735756321745, 53545.46454535483, 53946.19080713792, 43341.0, 54666.180007299925, 55687.0, 56675.43324566784, 56746.0, 14195.716085678436, 14702.55892323232, 14706.852931470763, 14780.63048423798, 14785.778213326808, 10955.397453139994, 11074.224804263786, 11107.278026928223, 11118.666440006813, 11242.325460472397, 17728.202230899642, 18181.7272740909, 18193.818061819213, 18252.908735456236, 18316.542086447946, 7544.773656790196, 7780.649870755829, 7796.376289896794, 7874.448788584744, 7920.168382319889, 845.0746432656232, 847.8516259654535, 856.5674334461182, 932.4125800745487, 967.57426732239, 25680.0, 26539.46921061568, 27017.45965080727, 27062.0, 27125.86437067802, 926.7868390270276, 941.0542404883049, 985.6796541124163, 1009.0968583118068, 1044.921630877672, 12416.441260143316, 13203.537876174289, 13768.449262029406, 14080.225587592577, 14160.079594826304, 338682.0, 345903.0, 346911.0, 349951.0, 350729.0, 49321.753391233535, 50035.0, 50202.49797502051, 50203.74898125486, 50771.0, 1204.8915597596083, 1226.0926914083514, 1226.533917111492, 1232.8890399863876, 1236.6042866282883, 25372.0, 25522.489550209262, 25837.483250335263, 26017.73982260229, 26105.0, 40722.59277407188, 40862.59137408588, 40923.18153636851, 41337.58662413337, 41338.1732365345, 247177.0, 251178.0, 253810.0, 254618.0, 254977.0, 27050.864745676146, 38057.61942380541, 40411.39382909318, 40766.79616601898, 40895.0, 36519.08702282358, 36883.262334753694, 37277.440838387985, 37287.881363559136, 37935.24129517449, 30332.84833575818, 31820.840895795372, 31864.0, 31959.0, 32127.518087228244, 30476.0, 30840.38319233558, 30953.69046309508, 30998.535021974236, 34252.0, 31021.534676979412, 31131.0, 31399.372012559164, 31641.20896977594, 32477.0, 25922.481550369263, 26213.606795898457, 28358.432831342845, 28428.43143137167, 28642.85678571594, 20441.795582044586, 20446.38660840177, 20490.59018819645, 20654.89672551688, 20681.27615533449], "prototype.html": [262.90141197051105, 264.97482739139787, 269.8111322074548, 279.1179871605726, 286.2600178538478, 5429.4570542945685, 5439.728013599324, 5513.476219759126, 5616.213730077788, 5630.239917611127, 5537.8061767838135, 5670.858228544288, 5681.517071048956, 5682.602217844742, 5709.086546152606, 4319.200947824663, 4354.042110735633, 4354.216241076605, 4374.803133858984, 4379.75911324877, 4329.718568293067, 4336.392904993303, 4357.760323182224, 4359.062801497677, 4375.365571992059, 4181.874543763677, 4294.184105020036, 4297.1405718856195, 4319.200947824646, 4348.934765978497, 4238.576142385752, 4272.423222864904, 4287.849925252601, 4298.247806633826, 4328.523862375137, 3689.782371817294, 3701.2967536168044, 3703.4444833275224, 3705.2033812730124, 3714.312852122339, 5426.565874730012, 5454.972725136349, 5471.261379713727, 5528.75120619573, 5537.667739935617, 4504.121696269229, 4596.3794887690065, 4743.596794272491, 4745.21703918853, 4792.640551958617, 5637.323521177444, 5721.628094173865, 5731.914021289684, 5756.107803290497, 5763.567732420043, 3814.275287695329, 3817.675497582709, 3823.751456155341, 3825.196708691178, 3876.4379165021196, 5991.370906054889, 6098.847528811815, 6100.633961962297, 6116.021436570172, 6128.233970753656, 3752.5872154063577, 3898.922021559553, 3902.6292502212814, 3910.432987216838, 3919.6668283195677, 3984.1234928315725, 3993.600639935983, 4002.699797515198, 4012.8996775080855, 4041.7574945503366, 4656.837010704609, 4659.534046595313, 4669.2062349400685, 4670.906581868411, 4695.366125573004, 5802.535797136219, 5809.535237181015, 5810.6513609183585, 5888.676122813286, 5902.970485147547, 1341.2824139085542, 1371.6570857285678, 1385.1273697570466, 1386.8890488760876, 1396.4972609860442, 884.8893888263967, 885.0087901550305, 890.7862113092812, 890.9109089091039, 892.607252808762, 5460.399356070829, 5479.287692600016, 5482.533984611273, 5486.231927530149, 5536.7231638418725, 6019.217501724747, 6029.577929544977, 6047.516198704093, 6054.576179667469, 6062.727177277033, 5400.540954018874, 5422.53908417781, 5430.158325459481, 5439.592030597721, 5452.59105567084, 3129.4054129715737, 3206.5671134397026, 3229.838508074587, 3238.3037646906027, 3249.1389781707867, 6063.393660633901, 6112.541559383064, 6146.293176284695, 6148.815535533941, 6157.138000679908, 6112.847178820565, 6116.908246376308, 6147.139400483936, 6147.293061297919, 6156.26124865019, 6068.969655151696, 6099.146119543178, 6109.419605137505, 6111.57218994675, 6118.908216376758, 5993.31076926159, 6002.819915402545, 6036.336003039574, 6054.54590905675, 6073.726682299395, 5744.798932037359, 5910.940890591039, 5923.49650279731, 5925.200097986716, 5932.110183472513, 6185.134081228542, 6185.8144255672405, 6190.7523699051535, 6207.099970504342, 6271.404216599416, 3721.7953012584567, 3733.6826369757787, 3784.1863999240295, 3812.1232116613887, 3823.9044023899623, 5793.826185214451, 5984.940150598438, 6012.0, 6022.156898034191, 6022.7289771959495, 5703.258576385209, 5733.512651424676, 5877.794277200277, 5903.409659034062, 5914.9944509432635, 5844.561657875592, 5883.735231914488, 5889.734961926638, 5932.317783454958, 5951.613145145551, 5567.8608034797835, 5720.771169153188, 5758.740856661544, 5771.769129234952, 5776.768929242783, 5809.738561764646, 5879.088741245114, 5899.528037757055, 5904.025835737055, 5931.436513531207, 5699.259096317618, 5729.4843464088435, 5745.540356771532, 5752.856178595402, 5758.62568933018], "yui.html": [574.262073235892, 606.9180660610816, 649.7563413719855, 655.8065370715639, 657.2901266632038, 11262.099032077434, 11606.013488853436, 11662.825057624143, 11671.766564668713, 11948.581799637015, 11220.214584979034, 11222.046126079293, 11238.438078096104, 11247.325160490376, 11289.604863829767, 773.3349319585152, 786.5280831501111, 790.1426951757321, 791.1179035375573, 798.0423491809822, 601.7923816283375, 618.2117799805239, 771.8340556780291, 801.390942883407, 813.9906515920246, 824.7855557555049, 835.7242110103651, 845.9492430454162, 847.0428415890036, 848.6478111583716, 835.2524490580896, 835.8453686068096, 836.1304243586662, 837.6063250272363, 853.63293783673, 619.8729260501586, 620.3083561828573, 623.4825095170997, 627.0249761620678, 627.5042716254154, 11671.883281167164, 11796.764064718744, 11819.822702659467, 11836.230645008047, 12068.09489288298, 8065.395095367812, 8307.08622051574, 8544.829103417958, 9899.554520046615, 10284.897151028468, 7728.922710772877, 7840.176781437924, 7877.527348359117, 8058.315043221333, 8409.243168114837, 2645.5899335603012, 2651.9867400663065, 2658.0, 2668.2929023808706, 2676.424568717735, 37615.0, 38050.80974595137, 38104.80947595272, 38124.809375952944, 38330.0, 5764.308283005982, 5864.354920958776, 5898.262717160355, 5900.793472228537, 6141.048137538689, 10312.27814053009, 10334.5349459273, 10335.069843714102, 10345.482725863827, 10384.636537721144, 5150.27896094547, 5222.373315202124, 5306.044911915815, 5411.242426060355, 5435.945640543544, 3150.984245078806, 3151.6218053833686, 3204.5033019881957, 3223.790453620554, 3269.983650081734, 2445.4986727720775, 2464.742981079662, 2471.270975062361, 2479.5784716598223, 2486.9554786989147, 350.76323481649786, 360.7132329797817, 368.0559365228181, 369.09755647442284, 370.8683417386789, 411.2925767679586, 463.84502588554255, 494.87875470509954, 496.3919198981219, 509.1039770004744, 6644.966775166094, 6716.529842910949, 6812.591244525344, 6813.523053386215, 6991.475639327071, 355.6088302866826, 377.6242638574636, 476.86647738632547, 498.3372115086926, 516.7700373333905, 3236.6116066072223, 3240.5301231321796, 3268.967310326914, 3288.3423315337027, 3364.915877103043, 51956.0, 52611.210831837554, 52994.73502632462, 53142.73428632832, 53432.73283633557, 43050.35424468636, 43160.352594711105, 43329.78335108367, 43480.56519434828, 43883.78058109689, 39597.80201098976, 41346.37980430296, 41534.1693166135, 42307.36538951918, 44717.99999999935, 7211.206767255493, 7247.2390399009455, 7259.491835571459, 7485.0643669541305, 7489.66296516669, 31476.527852082694, 31679.683203167675, 31694.683053170094, 31829.36341273208, 32452.675473244966, 37887.0, 38133.427998579486, 40790.71697471723, 41085.58914410937, 41369.37945930753, 9130.452172869649, 9424.198943089914, 9498.525073746423, 9748.122668959828, 9960.750981225527, 9432.481213533321, 9965.10314071737, 10170.542325595514, 10282.691519254435, 10561.260711750103, 9038.096190381173, 9099.408538444979, 9164.0, 9482.525873706425, 9772.218222542037, 9121.133492318218, 9141.26869850397, 9190.494522801042, 9299.953500232456, 9928.851067234142, 8897.421667591585, 9134.771630709285, 9145.725628231165, 9203.171714545722, 9453.054694530767, 7674.462787605037, 7685.423593230642, 7801.570913599579, 7997.360211182975, 8859.158379953895, 7472.775816725507, 7483.0, 7517.210692877169, 7565.0, 8056.7180148694515]}, "summary": {"lowerIsBetter": false, "suite": 5780.769650738206, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5699.147304037069, "unit": "ms", "value": 5699.147304037069}, "dojo.html": {"lowerIsBetter": false, "filtered": 4617.249285516467, "unit": "ms", "value": 4617.249285516467}, "mootools.html": {"lowerIsBetter": false, "filtered": 3891.0069995800636, "unit": "ms", "value": 3891.0069995800636}, "ext.html": {"lowerIsBetter": false, "filtered": 16434.005023302023, "unit": "ms", "value": 16434.005023302023}, "prototype.html": {"lowerIsBetter": false, "filtered": 4335.232461045655, "unit": "ms", "value": 4335.232461045655}, "yui.html": {"lowerIsBetter": false, "filtered": 5115.17333683089, "unit": "ms", "value": 5115.17333683089}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0074.e"}, "testrun": {"date": 1447422680, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113033432", "branch": "Fx-Team", "revision": "d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a"}}, {"talos_counters": {}, "results": {"audio-dft": [188.0, 200.0, 205.0, 204.0, 202.0, 198.0, 193.0, 193.0, 196.0, 204.0], "ai-astar": [122.0, 118.0, 135.0, 134.0, 129.0, 138.0, 132.0, 128.0, 135.0, 135.0], "imaging-gaussian-blur": [142.0, 142.0, 147.0, 136.0, 142.0, 143.0, 149.0, 145.0, 142.0, 143.0], "audio-beat-detection": [170.0, 162.0, 181.0, 192.0, 157.0, 179.0, 177.0, 150.0, 193.0, 157.0], "json-stringify-tinderbox": [74.0, 78.0, 78.0, 82.0, 80.0, 82.0, 81.0, 79.0, 78.0, 79.0], "stanford-crypto-pbkdf2": [170.0, 186.0, 184.0, 190.0, 192.0, 172.0, 184.0, 184.0, 184.0, 191.0], "json-parse-financial": [67.0, 72.0, 74.0, 74.0, 74.0, 76.0, 77.0, 78.0, 77.0, 78.0], "stanford-crypto-sha256-iterative": [78.0, 83.0, 90.0, 87.0, 88.0, 89.0, 88.0, 88.0, 89.0, 84.0], "audio-fft": [84.0, 84.0, 94.0, 138.0, 82.0, 80.0, 84.0, 89.0, 144.0, 81.0], "imaging-darkroom": [157.0, 157.0, 154.0, 151.0, 150.0, 157.0, 157.0, 155.0, 150.0, 157.0], "stanford-crypto-ccm": [152.0, 164.0, 150.0, 156.0, 156.0, 153.0, 163.0, 153.0, 157.0, 156.0], "audio-oscillator": [101.0, 105.0, 156.0, 106.0, 110.0, 111.0, 151.0, 104.0, 105.0, 150.0], "stanford-crypto-aes": [98.0, 101.0, 106.0, 106.0, 105.0, 107.0, 107.0, 102.0, 112.0, 119.0], "imaging-desaturate": [122.0, 118.0, 122.0, 125.0, 130.0, 117.0, 118.0, 117.0, 128.0, 122.0]}, "summary": {"lowerIsBetter": true, "suite": 1822.3000000000002, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 96.0, "unit": "ms", "value": 96.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 183.7, "unit": "ms", "value": 183.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 171.8, "unit": "ms", "value": 171.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 156.0, "unit": "ms", "value": 156.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 154.5, "unit": "ms", "value": 154.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 74.7, "unit": "ms", "value": 74.7}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 119.9, "unit": "ms", "value": 119.9}, "ai-astar": {"lowerIsBetter": true, "filtered": 130.6, "unit": "ms", "value": 130.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 198.3, "unit": "ms", "value": 198.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 86.4, "unit": "ms", "value": 86.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 79.1, "unit": "ms", "value": 79.1}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 143.1, "unit": "ms", "value": 143.1}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 106.3, "unit": "ms", "value": 106.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 121.9, "unit": "ms", "value": 121.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0074.e"}, "testrun": {"date": 1447422680, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113033432", "branch": "Fx-Team", "revision": "d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a"}}, {"talos_counters": {}, "results": {"DeltaBlue": [227.22108611679164], "Encrypt": [363.7686431429611], "NavierStokes": [6575.16339869281], "Decrypt": [6605.263157894737], "Splay": [745.156482861401], "Richards": [877.1929824561404], "RegExp": [33112.903225806454], "Earley": [904.9773755656108], "Boyer": [15303.030303030304], "RayTrace": [1298.7012987012988]}, "summary": {"lowerIsBetter": false, "suite": 14650.092781540046, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 290.98531800000006, "unit": "score", "value": 290.98531800000006}, "Encrypt": {"lowerIsBetter": false, "filtered": 731.7315690000003, "unit": "score", "value": 731.7315690000003}, "NavierStokes": {"lowerIsBetter": false, "filtered": 225.6978131212722, "unit": "score", "value": 225.6978131212722}, "Decrypt": {"lowerIsBetter": false, "filtered": 40.298318725099584, "unit": "score", "value": 40.298318725099584}, "Splay": {"lowerIsBetter": false, "filtered": 109.36092199999999, "unit": "score", "value": 109.36092199999999}, "RegExp": {"lowerIsBetter": false, "filtered": 27.511480759863588, "unit": "score", "value": 27.511480759863588}, "Richards": {"lowerIsBetter": false, "filtered": 40.24427999999998, "unit": "score", "value": 40.24427999999998}, "Earley": {"lowerIsBetter": false, "filtered": 736.4416150000001, "unit": "score", "value": 736.4416150000001}, "Boyer": {"lowerIsBetter": false, "filtered": 43.55104752475244, "unit": "score", "value": 43.55104752475244}, "RayTrace": {"lowerIsBetter": false, "filtered": 569.7915299999997, "unit": "score", "value": 569.7915299999997}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0074.e"}, "testrun": {"date": 1447422680, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151113033432", "branch": "Fx-Team", "revision": "d9813cc43ecc5ff5fdfdd8327a49ac0e82eaf64a"}}] 06:11:35 INFO - RETURN: dromaeo_css: 5780.77 06:11:35 INFO - RETURN: kraken: 1822.30 06:11:35 INFO - RETURN: v8_7: 14650.09 06:11:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "14650.09"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1822.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5780.77"}}} 06:11:36 INFO - Return code: 0 06:11:36 INFO - # TBPL SUCCESS # 06:11:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:11:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:11:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:11:36 INFO - 2015-11-13 06:11:36.023 screenresolution[1666:10747] starting screenresolution argv=screenresolution get 06:11:36 INFO - 2015-11-13 06:11:36.026 screenresolution[1666:10747] Display 0: 1600x1200x32@60 06:11:36 INFO - 2015-11-13 06:11:36.033 screenresolution[1667:10751] starting screenresolution argv=screenresolution list 06:11:36 INFO - Available Modes on Display 0 06:11:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:11:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:11:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:11:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:11:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:11:36 INFO - Intel HD Graphics 3000: 06:11:36 INFO - Chipset Model: Intel HD Graphics 3000 06:11:36 INFO - Type: GPU 06:11:36 INFO - Bus: Built-In 06:11:36 INFO - VRAM (Total): 512 MB 06:11:36 INFO - VRAM (Dynamic, Max): 10 06:11:36 INFO - Vendor: Intel (0x8086) 06:11:36 INFO - Device ID: 0x0116 06:11:36 INFO - Revision ID: 0x0009 06:11:36 INFO - Displays: 06:11:36 INFO - Display: 06:11:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:11:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:11:36 INFO - Display Serial Number: 1600x1200 60 06:11:36 INFO - Main Display: Yes 06:11:36 INFO - Mirror: Off 06:11:36 INFO - Online: Yes 06:11:36 INFO - Rotation: Supported 06:11:36 INFO - Return code: 0 06:11:36 INFO - Running post-action listener: _resource_record_post_action 06:11:36 INFO - Running post-run listener: _resource_record_post_run 06:11:37 INFO - Total resource usage - Wall time: 1258s; CPU: 30.0%; Read bytes: 41444352; Write bytes: 690027520; Read time: 5607; Write time: 74220 06:11:37 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 342456832; Write bytes: 335998976; Read time: 36901; Write time: 8155 06:11:37 INFO - run-tests - Wall time: 1217s; CPU: 30.0%; Read bytes: 39126016; Write bytes: 342895616; Read time: 4945; Write time: 63174 06:11:37 INFO - Running post-run listener: _upload_blobber_files 06:11:37 INFO - Blob upload gear active. 06:11:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:11:37 INFO - Copying logs to upload dir... 06:11:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1314.319517 ========= master_lag: 2.85 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2015-11-13 06:11:40.265060) ========= ========= Started set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-13 06:11:40.272074) ========= 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.pCgGu9K8GC/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.wWtfQNW5zV/Listeners TMPDIR=/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009929 build_url: 'https://queue.taskcluster.net/v1/task/sWrYFiysSAGpJCXR-deKyQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 1.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 1 secs) (at 2015-11-13 06:11:41.318273) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 06:11:41.318608) ========= 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.pCgGu9K8GC/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.wWtfQNW5zV/Listeners TMPDIR=/var/folders/n4/8zc_mvks7sv_04hmgss9q6rh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005314 ========= master_lag: 0.97 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-13 06:11:42.290162) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 06:11:42.290437) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-13 06:11:42.425609) ========= ========= Total master_lag: 4.98 =========