builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0025 starttime: 1448000844.47 results: success (0) buildid: 20151119211036 builduid: dcd87b7a8c9b4a67a2ac813c610d7193 revision: 1b2e15608f34fef0f23369731c80138f55f00cf2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.472791) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.473129) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.473493) ========= 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.xLagon7vLn/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.GkaKbPi6Ey/Listeners TMPDIR=/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005702 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.499177) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.499454) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.529571) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.529844) ========= 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.xLagon7vLn/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.GkaKbPi6Ey/Listeners TMPDIR=/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005403 ========= master_lag: 0.25 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.782747) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.783001) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.783336) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.783600) ========= 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.xLagon7vLn/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.GkaKbPi6Ey/Listeners TMPDIR=/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-19 22:27:24-- 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% 10.3M=0.001s 2015-11-19 22:27:24 (10.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.141984 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.939238) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.939567) ========= 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.xLagon7vLn/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.GkaKbPi6Ey/Listeners TMPDIR=/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019282 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:24.988276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-19 22:27:24.988647) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b2e15608f34fef0f23369731c80138f55f00cf2 --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 1b2e15608f34fef0f23369731c80138f55f00cf2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xLagon7vLn/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.GkaKbPi6Ey/Listeners TMPDIR=/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-19 22:27:25,060 truncating revision to first 12 chars 2015-11-19 22:27:25,060 Setting DEBUG logging. 2015-11-19 22:27:25,061 attempt 1/10 2015-11-19 22:27:25,061 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b2e15608f34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 22:27:27,172 unpacking tar archive at: fx-team-1b2e15608f34/testing/mozharness/ program finished with exit code 0 elapsedTime=2.351708 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2015-11-19 22:27:27.353791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:27.354066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:27.365366) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:27.365690) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 22:27:27.366103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-19 22:27:27.366402) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xLagon7vLn/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.GkaKbPi6Ey/Listeners TMPDIR=/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 22:27:27 INFO - MultiFileLogger online at 20151119 22:27:27 in /builds/slave/test 22:27:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 22:27:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:27:27 INFO - {'append_to_log': False, 22:27:27 INFO - 'base_work_dir': '/builds/slave/test', 22:27:27 INFO - 'blob_upload_branch': 'Fx-Team', 22:27:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:27:27 INFO - 'branch': 'Fx-Team', 22:27:27 INFO - 'buildbot_json_path': 'buildprops.json', 22:27:27 INFO - 'config_files': ('talos/mac_config.py',), 22:27:27 INFO - 'default_actions': ('clobber', 22:27:27 INFO - 'read-buildbot-config', 22:27:27 INFO - 'download-and-extract', 22:27:27 INFO - 'populate-webroot', 22:27:27 INFO - 'create-virtualenv', 22:27:27 INFO - 'install', 22:27:27 INFO - 'run-tests'), 22:27:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:27:27 INFO - 'download_minidump_stackwalk': True, 22:27:27 INFO - 'download_symbols': 'ondemand', 22:27:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:27:27 INFO - 'tooltool.py': '/tools/tooltool.py', 22:27:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:27:27 INFO - '/tools/misc-python/virtualenv.py')}, 22:27:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:27:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:27:27 INFO - 'installer_path': 'installer.exe', 22:27:27 INFO - 'log_level': 'info', 22:27:27 INFO - 'log_name': 'talos', 22:27:27 INFO - 'log_to_console': True, 22:27:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:27:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:27:27 INFO - 'opt_config_files': (), 22:27:27 INFO - 'pip_index': False, 22:27:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:27:27 INFO - 'cmd': ('bash', 22:27:27 INFO - '-c', 22:27:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:27:27 INFO - 'enabled': True, 22:27:27 INFO - 'halt_on_failure': False, 22:27:27 INFO - 'name': 'check_screen_resolution'},), 22:27:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:27:27 INFO - 'cmd': ('bash', 22:27:27 INFO - '-c', 22:27:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:27:27 INFO - 'enabled': True, 22:27:27 INFO - 'halt_on_failure': False, 22:27:27 INFO - 'name': 'check_screen_resolution'},), 22:27:27 INFO - 'run_cmd_checks_enabled': True, 22:27:27 INFO - 'sps_profile': False, 22:27:27 INFO - 'sps_profile_interval': 0, 22:27:27 INFO - 'suite': 'dromaeojs', 22:27:27 INFO - 'system_bits': '64', 22:27:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:27:27 INFO - 'title': 't-yosemite-r7-0025', 22:27:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:27:27 INFO - 'use_talos_json': True, 22:27:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:27:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:27:27 INFO - 'work_dir': 'build'} 22:27:27 INFO - ##### 22:27:27 INFO - ##### Running clobber step. 22:27:27 INFO - ##### 22:27:27 INFO - Running pre-action listener: _resource_record_pre_action 22:27:27 INFO - Running main action method: clobber 22:27:27 INFO - rmtree: /builds/slave/test/build 22:27:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:27:28 INFO - Running post-action listener: _resource_record_post_action 22:27:28 INFO - ##### 22:27:28 INFO - ##### Running read-buildbot-config step. 22:27:28 INFO - ##### 22:27:28 INFO - Running pre-action listener: _resource_record_pre_action 22:27:28 INFO - Running main action method: read_buildbot_config 22:27:28 INFO - Using buildbot properties: 22:27:28 INFO - { 22:27:28 INFO - "properties": { 22:27:28 INFO - "buildnumber": 5, 22:27:28 INFO - "product": "firefox", 22:27:28 INFO - "script_repo_revision": "production", 22:27:28 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 22:27:28 INFO - "repository": "", 22:27:28 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 22:27:28 INFO - "buildid": "20151119211036", 22:27:28 INFO - "slavename": "t-yosemite-r7-0025", 22:27:28 INFO - "pgo_build": "False", 22:27:28 INFO - "basedir": "/builds/slave/test", 22:27:28 INFO - "project": "", 22:27:28 INFO - "platform": "yosemite_r7", 22:27:28 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 22:27:28 INFO - "slavebuilddir": "test", 22:27:28 INFO - "scheduler": "tests-fx-team-macosx64-talos", 22:27:28 INFO - "branch": "fx-team", 22:27:28 INFO - "repo_path": "integration/fx-team", 22:27:28 INFO - "stage_platform": "macosx64", 22:27:28 INFO - "builduid": "dcd87b7a8c9b4a67a2ac813c610d7193", 22:27:28 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 22:27:28 INFO - }, 22:27:28 INFO - "sourcestamp": { 22:27:28 INFO - "repository": "", 22:27:28 INFO - "hasPatch": false, 22:27:28 INFO - "project": "", 22:27:28 INFO - "branch": "fx-team-macosx64-talos", 22:27:28 INFO - "changes": [ 22:27:28 INFO - { 22:27:28 INFO - "category": null, 22:27:28 INFO - "files": [ 22:27:28 INFO - { 22:27:28 INFO - "url": null, 22:27:28 INFO - "name": "https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 22:27:28 INFO - } 22:27:28 INFO - ], 22:27:28 INFO - "repository": "", 22:27:28 INFO - "rev": "1b2e15608f34fef0f23369731c80138f55f00cf2", 22:27:28 INFO - "who": "philringnalda@gmail.com", 22:27:28 INFO - "when": 1448000787, 22:27:28 INFO - "number": 6687063, 22:27:28 INFO - "comments": "Merge m-c to f-t", 22:27:28 INFO - "project": "", 22:27:28 INFO - "at": "Thu 19 Nov 2015 22:26:27", 22:27:28 INFO - "branch": "fx-team-macosx64-talos", 22:27:28 INFO - "revlink": "", 22:27:28 INFO - "properties": [ 22:27:28 INFO - [ 22:27:28 INFO - "buildid", 22:27:28 INFO - "20151119211036", 22:27:28 INFO - "Change" 22:27:28 INFO - ], 22:27:28 INFO - [ 22:27:28 INFO - "builduid", 22:27:28 INFO - "dcd87b7a8c9b4a67a2ac813c610d7193", 22:27:28 INFO - "Change" 22:27:28 INFO - ], 22:27:28 INFO - [ 22:27:28 INFO - "pgo_build", 22:27:28 INFO - "False", 22:27:28 INFO - "Change" 22:27:28 INFO - ] 22:27:28 INFO - ], 22:27:28 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 22:27:28 INFO - } 22:27:28 INFO - ], 22:27:28 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 22:27:28 INFO - } 22:27:28 INFO - } 22:27:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 22:27:28 INFO - Running post-action listener: _resource_record_post_action 22:27:28 INFO - ##### 22:27:28 INFO - ##### Running download-and-extract step. 22:27:28 INFO - ##### 22:27:28 INFO - Running pre-action listener: _resource_record_pre_action 22:27:28 INFO - Running main action method: download_and_extract 22:27:28 INFO - mkdir: /builds/slave/test/build/tests 22:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:28 INFO - https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:27:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/test_packages.json 22:27:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/test_packages.json 22:27:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:27:31 INFO - Downloaded 1149 bytes. 22:27:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:27:31 INFO - Using the following test package requirements: 22:27:31 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:27:31 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:31 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 22:27:31 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:31 INFO - u'jsshell-mac.zip'], 22:27:31 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:31 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 22:27:31 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:27:31 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:31 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 22:27:31 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:31 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 22:27:31 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:31 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 22:27:31 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 22:27:31 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 22:27:31 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 22:27:31 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 22:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:31 INFO - https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:27:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:27:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:27:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/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 22:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/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 22:27:32 INFO - Downloaded 17525138 bytes. 22:27:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 22:27:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:27:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:27:35 INFO - Return code: 0 22:27:35 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 22:27:35 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')]} 22:27:35 INFO - https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 22:27:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:27:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:27:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/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 22:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/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 22:27:36 INFO - Downloaded 17525138 bytes. 22:27:36 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 22:27:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 22:27:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 22:27:39 INFO - Return code: 0 22:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:39 INFO - https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 22:27:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:27:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:27:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/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 22:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/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 22:27:40 INFO - Downloaded 11130997 bytes. 22:27:40 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 22:27:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 22:27:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 22:27:41 INFO - Return code: 0 22:27:41 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')]} 22:27:41 INFO - https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 22:27:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:27:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:27:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 22:27:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/elKApx6KTOGP4UeVaVpX6Q/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 22:27:45 INFO - Downloaded 109413877 bytes. 22:27:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:27:45 INFO - mkdir: /builds/slave/test/properties 22:27:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:27:45 INFO - Writing to file /builds/slave/test/properties/build_url 22:27:45 INFO - Contents: 22:27:45 INFO - build_url:https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 22:27:45 INFO - Running post-action listener: _resource_record_post_action 22:27:45 INFO - Running post-action listener: set_extra_try_arguments 22:27:45 INFO - ##### 22:27:45 INFO - ##### Running populate-webroot step. 22:27:45 INFO - ##### 22:27:45 INFO - Running pre-action listener: _resource_record_pre_action 22:27:45 INFO - Running main action method: populate_webroot 22:27:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:27:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:27:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:27:45 INFO - '../fennec_ids.txt'], 22:27:45 INFO - 'tests': ['tcheck2']}, 22:27:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:27:45 INFO - '--tppagecycles', 22:27:45 INFO - '7'], 22:27:45 INFO - 'tests': ['tsvgm']}}, 22:27:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:27:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:27:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:27:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:27:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:27:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:27:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:45 INFO - 'talos_options': ['--e10s'], 22:27:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:27:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:45 INFO - 'tests': ['damp', 'tps']}, 22:27:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:45 INFO - 'talos_options': ['--e10s'], 22:27:45 INFO - 'tests': ['damp', 'tps']}, 22:27:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:27:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:27:45 INFO - 'other': {'tests': ['a11yr', 22:27:45 INFO - 'ts_paint', 22:27:45 INFO - 'tpaint', 22:27:45 INFO - 'sessionrestore', 22:27:45 INFO - 'sessionrestore_no_auto_restore']}, 22:27:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:27:45 INFO - 'tests': ['a11yr', 22:27:45 INFO - 'ts_paint', 22:27:45 INFO - 'tpaint', 22:27:45 INFO - 'sessionrestore', 22:27:45 INFO - 'sessionrestore_no_auto_restore']}, 22:27:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:27:45 INFO - 'tests': ['a11yr', 22:27:45 INFO - 'ts_paint', 22:27:45 INFO - 'tpaint', 22:27:45 INFO - 'sessionrestore', 22:27:45 INFO - 'sessionrestore_no_auto_restore']}, 22:27:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:27:45 INFO - 'tests': ['a11yr', 22:27:45 INFO - 'ts_paint', 22:27:45 INFO - 'tpaint', 22:27:45 INFO - 'sessionrestore', 22:27:45 INFO - 'sessionrestore_no_auto_restore']}, 22:27:45 INFO - 'other_l64': {'tests': ['a11yr', 22:27:45 INFO - 'ts_paint', 22:27:45 INFO - 'tpaint', 22:27:45 INFO - 'sessionrestore', 22:27:45 INFO - 'sessionrestore_no_auto_restore']}, 22:27:45 INFO - 'other_nol64': {'tests': ['a11yr', 22:27:45 INFO - 'ts_paint', 22:27:45 INFO - 'tpaint', 22:27:45 INFO - 'sessionrestore', 22:27:45 INFO - 'sessionrestore_no_auto_restore']}, 22:27:45 INFO - 'svgr': {'tests': ['tsvgx', 22:27:45 INFO - 'tsvgr_opacity', 22:27:45 INFO - 'tart', 22:27:45 INFO - 'tscrollx', 22:27:45 INFO - 'cart']}, 22:27:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:27:45 INFO - 'tests': ['tsvgx', 22:27:45 INFO - 'tsvgr_opacity', 22:27:45 INFO - 'tart', 22:27:45 INFO - 'tscrollx', 22:27:45 INFO - 'cart']}, 22:27:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:45 INFO - 'tests': ['tp5o']}, 22:27:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:45 INFO - 'talos_options': ['--e10s'], 22:27:45 INFO - 'tests': ['tp5o']}, 22:27:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:45 INFO - 'talos_options': ['--xperf_path', 22:27:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:45 INFO - 'tests': ['tp5n']}, 22:27:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:27:45 INFO - 'talos_options': ['--e10s', 22:27:45 INFO - '--xperf_path', 22:27:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:27:45 INFO - 'tests': ['tp5n']}}, 22:27:45 INFO - 'talos.zip': {'path': '', 22:27:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:27:45 INFO - Running post-action listener: _resource_record_post_action 22:27:45 INFO - ##### 22:27:45 INFO - ##### Running create-virtualenv step. 22:27:45 INFO - ##### 22:27:45 INFO - Running pre-action listener: _resource_record_pre_action 22:27:45 INFO - Running main action method: create_virtualenv 22:27:45 INFO - Creating virtualenv /builds/slave/test/build/venv 22:27:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:27:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:27:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:27:45 INFO - Using real prefix '/tools/python27' 22:27:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:27:46 INFO - Installing distribute.............................................................................................................................................................................................done. 22:27:49 INFO - Installing pip.................done. 22:27:49 INFO - Return code: 0 22:27:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104613490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb579c9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045379f0>, '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 0x104296db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/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.GkaKbPi6Ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:27:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/Render', 22:27:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:49 INFO - 'HOME': '/Users/cltbld', 22:27:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:49 INFO - 'LOGNAME': 'cltbld', 22:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:49 INFO - 'MOZ_NO_REMOTE': '1', 22:27:49 INFO - 'NO_EM_RESTART': '1', 22:27:49 INFO - 'PAGER': '/bin/cat', 22:27:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:49 INFO - 'PWD': '/builds/slave/test', 22:27:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:49 INFO - 'SHELL': '/bin/bash', 22:27:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkaKbPi6Ey/Listeners', 22:27:49 INFO - 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', 22:27:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:49 INFO - 'USER': 'cltbld', 22:27:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:49 INFO - 'XPC_FLAGS': '0x0', 22:27:49 INFO - 'XPC_SERVICE_NAME': '0', 22:27:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:49 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 22:27:49 INFO - Cleaning up... 22:27:49 INFO - Return code: 0 22:27:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104613490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb579c9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045379f0>, '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 0x104296db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/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.GkaKbPi6Ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:27:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:27:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:27:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/Render', 22:27:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:49 INFO - 'HOME': '/Users/cltbld', 22:27:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:49 INFO - 'LOGNAME': 'cltbld', 22:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:49 INFO - 'MOZ_NO_REMOTE': '1', 22:27:49 INFO - 'NO_EM_RESTART': '1', 22:27:49 INFO - 'PAGER': '/bin/cat', 22:27:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:49 INFO - 'PWD': '/builds/slave/test', 22:27:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:49 INFO - 'SHELL': '/bin/bash', 22:27:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkaKbPi6Ey/Listeners', 22:27:49 INFO - 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', 22:27:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:49 INFO - 'USER': 'cltbld', 22:27:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:49 INFO - 'XPC_FLAGS': '0x0', 22:27:49 INFO - 'XPC_SERVICE_NAME': '0', 22:27:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:49 INFO - Downloading/unpacking psutil>=0.7.1 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:49 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 22:27:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:27:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:27:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:52 INFO - Installing collected packages: psutil 22:27:52 INFO - Running setup.py install for psutil 22:27:52 INFO - building 'psutil._psutil_osx' extension 22:27:52 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 22:27:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 22:27:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 22:27:53 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 22:27:53 INFO - building 'psutil._psutil_posix' extension 22:27:53 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 22:27:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:27:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:27:53 INFO - ^ 22:27:53 INFO - 1 warning generated. 22:27:53 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 22:27:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:27:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:27:53 INFO - Successfully installed psutil 22:27:53 INFO - Cleaning up... 22:27:53 INFO - Return code: 0 22:27:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:27: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')]} 22:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27: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')]} 22:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:53 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 0x104613490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb579c9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045379f0>, '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 0x104296db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/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.GkaKbPi6Ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:27:53 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 22:27:53 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 22:27:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/Render', 22:27:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:53 INFO - 'HOME': '/Users/cltbld', 22:27:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:53 INFO - 'LOGNAME': 'cltbld', 22:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:53 INFO - 'MOZ_NO_REMOTE': '1', 22:27:53 INFO - 'NO_EM_RESTART': '1', 22:27:53 INFO - 'PAGER': '/bin/cat', 22:27:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:53 INFO - 'PWD': '/builds/slave/test', 22:27:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:53 INFO - 'SHELL': '/bin/bash', 22:27:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkaKbPi6Ey/Listeners', 22:27:53 INFO - 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', 22:27:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:53 INFO - 'USER': 'cltbld', 22:27:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:53 INFO - 'XPC_FLAGS': '0x0', 22:27:53 INFO - 'XPC_SERVICE_NAME': '0', 22:27:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:27:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:27:56 INFO - Installing collected packages: mozsystemmonitor 22:27:56 INFO - Running setup.py install for mozsystemmonitor 22:27:56 INFO - Successfully installed mozsystemmonitor 22:27:56 INFO - Cleaning up... 22:27:56 INFO - Return code: 0 22:27:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104613490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb579c9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045379f0>, '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 0x104296db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/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.GkaKbPi6Ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/Render', 22:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:27:56 INFO - 'HOME': '/Users/cltbld', 22:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:27:56 INFO - 'LOGNAME': 'cltbld', 22:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:27:56 INFO - 'MOZ_NO_REMOTE': '1', 22:27:56 INFO - 'NO_EM_RESTART': '1', 22:27:56 INFO - 'PAGER': '/bin/cat', 22:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:27:56 INFO - 'PWD': '/builds/slave/test', 22:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:27:56 INFO - 'SHELL': '/bin/bash', 22:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkaKbPi6Ey/Listeners', 22:27:56 INFO - 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', 22:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:27:56 INFO - 'USER': 'cltbld', 22:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:27:56 INFO - 'XPC_FLAGS': '0x0', 22:27:56 INFO - 'XPC_SERVICE_NAME': '0', 22:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:27:56 INFO - Downloading/unpacking blobuploader==1.2.4 22:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:58 INFO - Downloading blobuploader-1.2.4.tar.gz 22:27:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:27:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:27:58 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 22:27:58 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 22:27:58 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 22:27:58 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 22:27:58 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 22:27:58 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 22:27:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:27:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:27:59 INFO - Downloading docopt-0.6.1.tar.gz 22:27:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:27:59 INFO - Installing collected packages: blobuploader, requests, docopt 22:27:59 INFO - Running setup.py install for blobuploader 22:27:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:28:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:28:00 INFO - Running setup.py install for requests 22:28:00 INFO - Running setup.py install for docopt 22:28:00 INFO - Successfully installed blobuploader requests docopt 22:28:00 INFO - Cleaning up... 22:28:00 INFO - Return code: 0 22:28:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:00 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 0x104613490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb579c9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045379f0>, '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 0x104296db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/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.GkaKbPi6Ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:28:00 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 22:28:00 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 22:28:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/Render', 22:28:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:00 INFO - 'HOME': '/Users/cltbld', 22:28:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:00 INFO - 'LOGNAME': 'cltbld', 22:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:00 INFO - 'MOZ_NO_REMOTE': '1', 22:28:00 INFO - 'NO_EM_RESTART': '1', 22:28:00 INFO - 'PAGER': '/bin/cat', 22:28:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:00 INFO - 'PWD': '/builds/slave/test', 22:28:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:00 INFO - 'SHELL': '/bin/bash', 22:28:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkaKbPi6Ey/Listeners', 22:28:00 INFO - 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', 22:28:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:00 INFO - 'USER': 'cltbld', 22:28:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:00 INFO - 'XPC_FLAGS': '0x0', 22:28:00 INFO - 'XPC_SERVICE_NAME': '0', 22:28:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:28:00 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-IHityx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:28:01 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-JI3nqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:28:01 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-s39m_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:28:01 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-ZOxXFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:28:01 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-3pR0Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:28:01 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-8adwf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:28:01 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-xWX2Cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:28:01 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-PTNcHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:28:01 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-2MPYUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:28:01 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-DztUXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:28:02 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-Ka0awQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:28:02 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-rgj3xX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:28:02 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-6fBsrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:28:02 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-654v8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:02 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-ruIbhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:28:02 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-uyN_4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:28:02 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-kxZV5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:28:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:28:02 INFO - Running setup.py install for manifestparser 22:28:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:28:02 INFO - Running setup.py install for mozcrash 22:28:03 INFO - Running setup.py install for mozdebug 22:28:03 INFO - Running setup.py install for mozdevice 22:28:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:28:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:28:03 INFO - Running setup.py install for mozfile 22:28:03 INFO - Running setup.py install for mozhttpd 22:28:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:28:03 INFO - Running setup.py install for mozinfo 22:28:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:28:03 INFO - Running setup.py install for mozInstall 22:28:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:28:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:28:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:28:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:28:03 INFO - Running setup.py install for mozleak 22:28:04 INFO - Running setup.py install for mozlog 22:28:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Running setup.py install for moznetwork 22:28:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Running setup.py install for mozprocess 22:28:04 INFO - Running setup.py install for mozprofile 22:28:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Running setup.py install for mozrunner 22:28:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:28:04 INFO - Running setup.py install for mozscreenshot 22:28:04 INFO - Running setup.py install for moztest 22:28:05 INFO - Running setup.py install for mozversion 22:28:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:28:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:28:05 INFO - Cleaning up... 22:28:05 INFO - Return code: 0 22:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28:05 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')]} 22:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:05 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')]} 22:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28:05 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 0x104613490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb579c9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045379f0>, '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 0x104296db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/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.GkaKbPi6Ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:28:05 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 22:28:05 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 22:28:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/Render', 22:28:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:05 INFO - 'HOME': '/Users/cltbld', 22:28:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:05 INFO - 'LOGNAME': 'cltbld', 22:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:05 INFO - 'MOZ_NO_REMOTE': '1', 22:28:05 INFO - 'NO_EM_RESTART': '1', 22:28:05 INFO - 'PAGER': '/bin/cat', 22:28:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:05 INFO - 'PWD': '/builds/slave/test', 22:28:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:05 INFO - 'SHELL': '/bin/bash', 22:28:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkaKbPi6Ey/Listeners', 22:28:05 INFO - 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', 22:28:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:05 INFO - 'USER': 'cltbld', 22:28:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:05 INFO - 'XPC_FLAGS': '0x0', 22:28:05 INFO - 'XPC_SERVICE_NAME': '0', 22:28:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:28:05 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-mgCrLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:28:05 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)) 22:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:28:05 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-vLcZRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:28:05 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)) 22:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:28:05 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-lV_n1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:28:05 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)) 22:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:28:05 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-eASINU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:28:05 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)) 22:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:28:05 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-1Ho9z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:28:06 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-rofdsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:28:06 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-RkVScQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:28:06 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-oNV7gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:28:06 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-bdCBCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:28:06 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-WPAi6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:28:06 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-fktq6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:28:06 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-uOvtXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:28:06 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-W_K4Tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:28:06 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)) 22:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:28:06 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-R9yfN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:28:07 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:07 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-KdClEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:28:07 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:28:07 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-UoRYth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:28:07 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)) 22:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:28:07 INFO - Running setup.py (path:/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/pip-mnapFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:28:07 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)) 22:28:07 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)) 22:28:07 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)) 22:28:07 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)) 22:28:07 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)) 22:28:07 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)) 22:28:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:28:07 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 22:28:07 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 22:28:07 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 22:28:07 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 22:28:07 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 22:28:07 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 22:28:09 INFO - Downloading blessings-1.5.1.tar.gz 22:28:09 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 22:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:28:09 INFO - Installing collected packages: blessings 22:28:09 INFO - Running setup.py install for blessings 22:28:09 INFO - Successfully installed blessings 22:28:09 INFO - Cleaning up... 22:28:09 INFO - Return code: 0 22:28:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:28:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:28:10 INFO - Reading from file tmpfile_stdout 22:28:10 INFO - Current package versions: 22:28:10 INFO - blessings == 1.5.1 22:28:10 INFO - blobuploader == 1.2.4 22:28:10 INFO - docopt == 0.6.1 22:28:10 INFO - manifestparser == 1.1 22:28:10 INFO - mozInstall == 1.12 22:28:10 INFO - mozcrash == 0.16 22:28:10 INFO - mozdebug == 0.1 22:28:10 INFO - mozdevice == 0.47 22:28:10 INFO - mozfile == 1.2 22:28:10 INFO - mozhttpd == 0.7 22:28:10 INFO - mozinfo == 0.9 22:28:10 INFO - mozleak == 0.1 22:28:10 INFO - mozlog == 3.0 22:28:10 INFO - moznetwork == 0.27 22:28:10 INFO - mozprocess == 0.22 22:28:10 INFO - mozprofile == 0.27 22:28:10 INFO - mozrunner == 6.11 22:28:10 INFO - mozscreenshot == 0.1 22:28:10 INFO - mozsystemmonitor == 0.0 22:28:10 INFO - moztest == 0.7 22:28:10 INFO - mozversion == 1.4 22:28:10 INFO - psutil == 3.1.1 22:28:10 INFO - requests == 1.2.3 22:28:10 INFO - wsgiref == 0.1.2 22:28:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:28: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')]} 22:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28: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')]} 22:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:28: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', '-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 0x104613490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045f0228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb579c9bcf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045379f0>, '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 0x104296db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452a8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/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.GkaKbPi6Ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 22:28:10 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 22:28:10 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 22:28:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/Render', 22:28:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:10 INFO - 'HOME': '/Users/cltbld', 22:28:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:10 INFO - 'LOGNAME': 'cltbld', 22:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:10 INFO - 'MOZ_NO_REMOTE': '1', 22:28:10 INFO - 'NO_EM_RESTART': '1', 22:28:10 INFO - 'PAGER': '/bin/cat', 22:28:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:10 INFO - 'PWD': '/builds/slave/test', 22:28:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:10 INFO - 'SHELL': '/bin/bash', 22:28:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkaKbPi6Ey/Listeners', 22:28:10 INFO - 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', 22:28:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:10 INFO - 'USER': 'cltbld', 22:28:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:10 INFO - 'XPC_FLAGS': '0x0', 22:28:10 INFO - 'XPC_SERVICE_NAME': '0', 22:28:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:28:10 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)) 22:28:10 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)) 22:28:10 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)) 22:28:10 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)) 22:28:10 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)) 22:28:10 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)) 22:28:10 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)) 22:28:10 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)) 22:28:10 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)) 22:28:10 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)) 22:28:10 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)) 22:28:10 INFO - Cleaning up... 22:28:10 INFO - Return code: 0 22:28:10 INFO - Running post-action listener: _resource_record_post_action 22:28:10 INFO - Running post-action listener: _start_resource_monitoring 22:28:10 INFO - Starting resource monitoring. 22:28:10 INFO - ##### 22:28:10 INFO - ##### Running install step. 22:28:10 INFO - ##### 22:28:10 INFO - Running pre-action listener: _resource_record_pre_action 22:28:10 INFO - Running main action method: install 22:28:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:28:10 INFO - Reading from file tmpfile_stdout 22:28:10 INFO - Detecting whether we're running mozinstall >=1.0... 22:28:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:28:10 INFO - Reading from file tmpfile_stdout 22:28:10 INFO - Output received: 22:28:10 INFO - Usage: mozinstall [options] installer 22:28:10 INFO - Options: 22:28:10 INFO - -h, --help show this help message and exit 22:28:10 INFO - -d DEST, --destination=DEST 22:28:10 INFO - Directory to install application into. [default: 22:28:10 INFO - "/builds/slave/test"] 22:28:10 INFO - --app=APP Application being installed. [default: firefox] 22:28:10 INFO - mkdir: /builds/slave/test/build/application 22:28:10 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'] 22:28:10 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 22:28:41 INFO - Reading from file tmpfile_stdout 22:28:41 INFO - Output received: 22:28:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 22:28:41 INFO - Running post-action listener: _resource_record_post_action 22:28:41 INFO - ##### 22:28:41 INFO - ##### Running run-tests step. 22:28:41 INFO - ##### 22:28:41 INFO - Running pre-action listener: _resource_record_pre_action 22:28:41 INFO - Running main action method: run_tests 22:28:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:28:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:28:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:28:41 INFO - 2015-11-19 22:28:41.030 screenresolution[1924:10442] starting screenresolution argv=screenresolution get 22:28:41 INFO - 2015-11-19 22:28:41.032 screenresolution[1924:10442] Display 0: 1600x1200x32@60 22:28:41 INFO - 2015-11-19 22:28:41.038 screenresolution[1925:10445] starting screenresolution argv=screenresolution list 22:28:41 INFO - Available Modes on Display 0 22:28:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:28:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:28:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:28:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:28:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:28:41 INFO - Intel Iris: 22:28:41 INFO - Chipset Model: Intel Iris 22:28:41 INFO - Type: GPU 22:28:41 INFO - Bus: Built-In 22:28:41 INFO - VRAM (Dynamic, Max): 1536 MB 22:28:41 INFO - Vendor: Intel (0x8086) 22:28:41 INFO - Device ID: 0x0a2e 22:28:41 INFO - Revision ID: 0x0009 22:28:41 INFO - Displays: 22:28:41 INFO - Display: 22:28:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:28:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:28:41 INFO - Display Serial Number: 1600x1200 60 22:28:41 INFO - Main Display: Yes 22:28:41 INFO - Mirror: Off 22:28:41 INFO - Online: Yes 22:28:41 INFO - Rotation: Supported 22:28:41 INFO - Return code: 0 22:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:28:41 INFO - Python 2.7.3 22:28:41 INFO - Return code: 0 22:28:41 INFO - grabbing minidump binary from tooltool 22:28:41 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')]} 22:28:41 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 0x1045379f0>, '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 0x104296db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10452a8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:28:41 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 22:28:41 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 22:28:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:28:41 INFO - Return code: 0 22:28:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:28:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:28:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:28:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:28:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost'] in /builds/slave/test/build 22:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0025 --webServer localhost 22:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xLagon7vLn/Render', 22:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:28:41 INFO - 'HOME': '/Users/cltbld', 22:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:28:41 INFO - 'LOGNAME': 'cltbld', 22:28:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:28:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:28:41 INFO - 'MOZ_NO_REMOTE': '1', 22:28:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:28:41 INFO - 'NO_EM_RESTART': '1', 22:28:41 INFO - 'PAGER': '/bin/cat', 22:28:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:28:41 INFO - 'PWD': '/builds/slave/test', 22:28:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:28:41 INFO - 'SHELL': '/bin/bash', 22:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GkaKbPi6Ey/Listeners', 22:28:41 INFO - 'TMPDIR': '/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/', 22:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:28:41 INFO - 'USER': 'cltbld', 22:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:28:41 INFO - 'XPC_FLAGS': '0x0', 22:28:41 INFO - 'XPC_SERVICE_NAME': '0', 22:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:28:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost'] with output_timeout 3600 22:28:41 INFO - mozversion INFO | application_buildid: 20151119211036 22:28:41 INFO - mozversion INFO | application_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 22:28:41 INFO - mozversion INFO | application_display_name: Nightly 22:28:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:28:41 INFO - mozversion INFO | application_name: Firefox 22:28:41 INFO - mozversion INFO | application_remotingname: firefox 22:28:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:28:41 INFO - mozversion INFO | application_vendor: Mozilla 22:28:41 INFO - mozversion INFO | application_version: 45.0a1 22:28:41 INFO - mozversion INFO | platform_buildid: 20151119211036 22:28:41 INFO - mozversion INFO | platform_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 22:28:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:28:41 INFO - mozversion INFO | platform_version: 45.0a1 22:28:41 INFO - 2015-11-19 22:28:41,573 DEBUG : using testdate: 1448000921 22:28:41 INFO - 2015-11-19 22:28:41,573 DEBUG : actual date: 1448000921 22:28:42 INFO - 2015-11-19 22:28:42,105 INFO : starting webserver on 'localhost:49392' 22:28:42 INFO - 2015-11-19 22:28:42,106 INFO : Starting test suite t-yosemite-r7-0025 22:28:42 INFO - 2015-11-19 22:28:42,106 INFO : Starting test dromaeo_css 22:28:42 INFO - 2015-11-19 22:28:42,107 DEBUG : operating with platform_type : mac_ 22:28:42 INFO - 2015-11-19 22:28:42,108 INFO : Initialising browser for dromaeo_css test... 22:28:42 INFO - 2015-11-19 22:28:42,120 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/tmpbdSJh5/profile http://localhost:49392/getInfo.html 22:28:44 INFO - 2015-11-19 22:28:44,110 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:28:44 INFO - 2015-11-19 22:28:44,110 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:28:44 INFO - 2015-11-19 22:28:44,111 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:28:44 INFO - 2015-11-19 22:28:44,111 DEBUG : BROWSER_OUTPUT: __metrics 22:28:44 INFO - 2015-11-19 22:28:44,126 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:28:44 INFO - 2015-11-19 22:28:44,774 INFO : Browser initialized. 22:28:44 INFO - 2015-11-19 22:28:44,774 INFO : Running cycle 1/1 for dromaeo_css test... 22:28:44 INFO - 2015-11-19 22:28:44,774 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/tmpbdSJh5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:28:56 INFO - 2015-11-19 22:28:56,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 225386496 22:28:56 INFO - 2015-11-19 22:28:56,553 DEBUG : BROWSER_OUTPUT: 22:29:47 INFO - 2015-11-19 22:29:47,596 DEBUG : BROWSER_OUTPUT: 1448000987591 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] 22:31:58 INFO - 2015-11-19 22:31:58,829 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49392/tests/dromaeo/cssquery-ext.html) 22:32:00 INFO - 2015-11-19 22:32:00,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 364351488 22:32:00 INFO - 2015-11-19 22:32:00,264 DEBUG : BROWSER_OUTPUT: 22:35:03 INFO - 2015-11-19 22:35:03,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-ext.html (next: http://localhost:49392/tests/dromaeo/cssquery-jquery.html) 22:35:03 INFO - 2015-11-19 22:35:03,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 365461504 22:35:03 INFO - 2015-11-19 22:35:03,619 DEBUG : BROWSER_OUTPUT: 22:38:05 INFO - 2015-11-19 22:38:05,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49392/tests/dromaeo/cssquery-mootools.html) 22:38:06 INFO - 2015-11-19 22:38:06,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 376643584 22:38:06 INFO - 2015-11-19 22:38:06,294 DEBUG : BROWSER_OUTPUT: 22:41:08 INFO - 2015-11-19 22:41:08,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49392/tests/dromaeo/cssquery-prototype.html) 22:41:08 INFO - 2015-11-19 22:41:08,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 325570560 22:41:08 INFO - 2015-11-19 22:41:08,861 DEBUG : BROWSER_OUTPUT: 22:44:11 INFO - 2015-11-19 22:44:11,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49392/tests/dromaeo/cssquery-yui.html) 22:44:12 INFO - 2015-11-19 22:44:12,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 323432448 22:44:12 INFO - 2015-11-19 22:44:12,369 DEBUG : BROWSER_OUTPUT: 22:47:14 INFO - 2015-11-19 22:47:14,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/dromaeo/cssquery-yui.html (next: http://localhost:49392/tests/dromaeo/cssquery-dojo.html) 22:47:15 INFO - 2015-11-19 22:47:15,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 386170880 22:47:15 INFO - 2015-11-19 22:47:15,195 DEBUG : BROWSER_OUTPUT: 22:47:15 INFO - 2015-11-19 22:47:15,195 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:47:15 INFO - 2015-11-19 22:47:15,195 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:47:15 INFO - 2015-11-19 22:47:15,195 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:47:15 INFO - 2015-11-19 22:47:15,195 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:47:15 INFO - 2015-11-19 22:47:15,197 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3425.417678994571;3501.474778783182;3512.086857417072;3538.221591249924;3555.875544355948;5712.086066229404;5815.941840581593;5929.110633404992;5990.4309090636425;6041.1542384066215;5905.291365036202;5922.585419020659;5947.524198064155;6013.759449622021;6126.908096378546;5335.5198032177095;5367.570594352462;5369.785208591671;5384.057789886774;5399.649022813504;5470.9452905471035;5486.533644640211;5492.395836457987;5493.121100623901;5515.696636684981;4334;5204.583633309327;5359.490848369399;5426.810061647843;5485.341758988927;5392.40683524812;5402.8109016184635;5419.566434685215;5422;5430.185472179205;5244.947550524484;5320.361556613192;5398;5399.136138217906;5404.51359377654;5857.502112320458;5903.996320625504;5958.702064896781;5966.134910437962;6002.429769171922;6334;6358.33237510064;6361.332060133665;6362.459190968773;6364.2681091674585;6130.908036379458;6170.19787427636;6260;6424.100625912376;6444.806655800334;5999.370066143079;6045.993880128394;6094.849668001284;6106.45041946218;6134.723937422782;6441.935580644227;6444.516661250425;6502.642354670444;6517.217933847968;6530.510211734044;6120.314383336517;6252.781152659635;6259.217597800275;6313.179286692793;6334;6285.528585356116;6387.297397286295;6403.167588213502;6405.135306733625;6407.775727849503;6291.1192433059405;6296.150019747275;6302.369763023753;6308.179936608211;6313.021481670348;6183.3816618337805;6295.087212354275;6298.307186209513;6309.14826498426;6348.079528468346;5016.347874776256;5029.798808047711;5068.898622027539;5077.974610126926;5124.333836601292;4565.086982603492;4594.402727645452;4606.447226332862;4608.009278005245;4631.3516107744945;4944.208926571731;5755.8561035974435;5894.233749612608;6039.4262545058145;6048.848778780566;6253.6560489173535;6333.46165575922;6346.079818426395;6356.919323714979;6362.618242905441;5963.850903727442;5968.552358573124;5973.701314934323;5978.641281523122;5990.251218597676;5400.270963419888;5505.587080968943;5520.861978450571;5524.392316845144;5582.97208513963;6325.936740632719;6388.201474815648;6430.324815894263;6443.065755465525;6451.967740161269;6377.936220637735;6410.775622853178;6433.260175079926;6437.356264373525;6461.8061458156335;6538.869222615426;6562.507811914221;6585.5719378240265;6591.835204119935;6595.472362211108;6187.412195841388;6206.565540412128;6307.873842523216;6334.3665633436285;6341.55609107358;6351.174347334817;6383.138276332821;6384.744610215539;6409.583377080475;6411.070394792822;6146.569740118149;6262.686865656608;6312.810615681537;6316.62100273985;6340.651264180515;6124.724387402489;6214.751409943552;6230.376962303733;6241.375862413723;6309.842253943688;6124.693765311806;6133.355997620186;6175.073738939015;6192.907106393498;6241.719122639583;6286.5599408041;6312.842178945563;6324.430801227728;6325;6333.841653958688;6218.657973811484;6265.4361107500545;6285.214348206474;6291.653959032297;6299.212598425197 22:47:15 INFO - 2015-11-19 22:47:15,201 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.0719295180572;554.373557879596;588.7468388592903;588.9310900715199;598.9099838294305;24669.876650616745;32188;39664;39949.60050399495;40164.799176004155;35344.46983295253;43311.13377732444;43605.56394436055;43692.3446148308;43703;9716.125548700633;9915.900840991606;9919.553620087114;9929.702108936708;9933.900660993406;8897.866532002025;9013.324000699973;9013.864792028126;9019.413738107001;9025.368224224307;8874.86687699685;11780.469878855472;11898.107641926847;11904.285742855413;11918.28490290581;11753.529858805638;11789.233699809485;11801;11812.586559470463;11816;8887.200151986352;9019.954900225457;11545.249558778652;11698.2981021139;11723.765524689543;31999;42775.14449710988;42864.357034644505;42899.785501072605;43076.13847723059;3213.935721285585;3295.40682677118;3488.947665785015;3728.9627103728885;4067.5322337930925;28171.619405671245;28302.858485707646;28857.422851543062;29109.272268193254;29125.854370728222;2791.6929137794828;2858.1854171561004;2878.280429892527;2881.150060732089;2904;505967;508247;509401.45299273636;509596;510380;57459.425405746246;70020;70372.94440583396;70478.64760676163;70596.64701676561;71668;71871;71876.64061679658;71902.64048679723;72049;16506.58733531647;16882.15589220534;16904.746428803577;16912.915435422743;16958.830411695973;12787.040971927143;12867.42096605655;12889.742205156032;12893.871061289266;12894.29081400532;16728.749068763977;21251;21483.46291342729;21709.67435488469;21736.239231626816;9504.667336643184;9742.951285243671;9766.804663906682;9785.951070244602;9803.313768036169;849.4308813095241;965.2760429677742;1059.750958524746;1079.3685693869174;1111.3998440841856;29472.705272946994;29666.406671866873;29878.850605746833;30231;30296.394072118434;1028.2391030637425;1069.7165251208437;1135.994320028411;1186.5609724402027;1211.9697007574882;14815.259237038104;14822.332995015251;15068.246587670572;15204.923975380274;15353.309101090477;536504;541268;542206;542588;543288.5671143318;50878.23682644763;51146.721331966255;51177.74411127921;62235.37764622386;62243;1268.1566758105942;1476.2840022589037;1505.0442968714945;1506.1791323728814;1535.109636410879;28154.43691126207;31206;31889;31932;32648.673513264563;56405.71797140988;57126;57158.7142064287;57167;57170.714146429;448369.3070742508;449168;452023;453495;453948;32559.674403255663;33975.66024339824;34687.653123468444;44957.55042449533;46922.53077469318;46719.29921051119;46963.765181175244;48004.5199548014;48289.517104828505;48335.27497087617;29414.852925735235;37460.06349841276;38987.41518877162;39823.60176398199;41099;31224;37631;38396.80801596086;39128.41307380335;39412;37841.24317513689;38419.231615366974;38973.8051309753;39002.219955600165;39095.02262443462;32364.83817580897;34905.825470872485;34968.65031349654;35391;35850.46224306586;25109.623355650045;25269.87365063163;25277.87361063183;25396.746032540177;25625.487490250463 22:47:15 INFO - 2015-11-19 22:47:15,201 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.3371396060308;359.20436233742265;363.870825856821;365.27675203097857;369.48272418613936;16201.756973645404;17848.910755446235;19770.30803921863;20597.588048239046;21303.57392852144;20269.898650506726;20278.493037674067;20756.792432075676;20757.065932033056;20777.16891324349;4040.5353384360733;5281.155015197579;5422.267993820843;5427.3215848019;5438.972805135969;4115.444415003981;4145;5849.824505264827;6037.305709843358;6054.8183554493435;5943.524518038546;6030.849228769272;6048.909266361008;6054.303755068157;6575.80272591823;6546.378094081055;6563.57336773113;6572.342765723437;6579.671016449182;6593.044008618771;4714.528547145293;5464.535514481274;5625.71871406428;5628.409017053233;5693.17448969897;12417.689557761038;12785.488580456771;12832.871671283261;12852.55016074433;12870.356482175854;1911.827935485813;1970.1922211893198;2010.3064442767222;2051.2307884543297;2069.1206237349065;8683.956580217122;9783.608655653765;9981.351212171257;10010.49947502622;10154.492275386201;1698.3206717313174;1721.7589537464764;1727.136431784108;1735.8437740603406;1735.8698097642728;90043;95047.52476237643;96407.0359296412;96528;97303.51348243213;11058.834117488244;11116.944415277872;11130.888691113147;11139.888601114048;11191.99272065518;13156;13188.340582970814;13191.274479903697;13195.736085278433;13199.40602672882;8404.991401031915;8464.915350846413;8467;8514.233718965323;8548.914510854936;8688.044315125331;8704.695335663222;8727;8827.646894124291;8840.778980525409;3790.56408513019;4294.119705460374;4336.392904993303;4342.1532801103485;4375.16871794358;1750.2823842224882;1777.6800175968192;1789.0965062643543;1790.4628611416522;1790.9283628654969;900.7162743735834;938.9436633801994;947.1712251779693;1058.8888166742536;1095.6001059613184;19439.416817495498;20359.491012724506;21262.830544319902;21323.90803333508;21606.351809445743;932.7854593443546;986.7730422002979;992.4144754594823;1014.2342531388754;1049.7847941172042;10973.725656858642;11519.827202591969;11716.297022178696;11755.118366122575;11807.173497855068;716911;718872;728637;734232;747886;91031.54484227537;122995.77004230022;123520;123573;127108;1230.9076819238594;1231.4889320931893;1235.4131787400913;1239.4546399584153;1260.8297879786294;15533.533993980198;17490.82509174892;19007.714884277022;19021.90489047546;19334.516637084187;50046.749766250934;50442.49557504525;50511.989760205324;50572.24141637952;51152;69641.80564288546;70420;70970.22574435681;71110.28889711037;74823.62588187025;10016.549255283384;10128.949355253177;10149.137323327599;10406.791864162524;10490.632827850988;11926.344051077274;13782.793258100935;20571.588568228253;20966.895165524074;21294.893525532272;11833.881661183277;14379.784303235669;16477.505674829776;16754.827162099024;16797.832021679627;12400;12675.619731408073;15823.841761582236;16464.176791160153;16540.917295413445;16183.271752770917;16910.746338805173;17016;17020.14899255057;17053;9702.272329575451;9978.800423991624;10000.899990999997;10070.69787906364;10148.492575371054;10314.948425257826;12576.434060467118;15998.360065597246;16498.25757840924;17033.91483042577 22:47:15 INFO - 2015-11-19 22:47:15,203 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1332.3072002558663;1566.3264796137655;1568.1140155811966;1850.8704390692653;1868.0753027251512;7450.552966821988;7601.239876012396;7614.543127412352;8055.234752698499;8348.749537513884;8158.0618228903695;8192.7951801205;8345.956755405574;8358.707445239417;8361.372897032716;2356.045801450415;2389.7251816041203;2389.880505974703;2390.259019703897;2391.1869964212165;2360.3509035015336;2415.4685969086772;2421.7578242175728;2423.9394015149587;2424.87875606219;2036.4705176654102;2198.6152423325852;2368.111958015744;2383.3207535852284;2387.808975281982;2321.3848330192513;2358.6344116661858;2364.7635236476217;2374.2046414451265;2374.6675465434855;2364.373441038126;2390.725066617344;2406.3743426709007;2409.795167410772;2411.7347091819884;8281;8352.958235208846;8358.791030224233;8362.623681934327;8392.03491598468;4620.19146649335;4783.832565860178;4811.13399588074;5069.847904562869;5228.8692782680355;3493.6506349365113;3512.5609298837644;3533.876314328986;3539.8407071681836;3568.518250036238;1032.4992378696327;1032.6420756704983;1043.1446214104437;1053.7839742852698;1057.5981127171626;10911.454427278604;10986.176036797273;11016.449177541172;11025.007749302602;11028.393438360887;3918.9020274493364;4478.193925093515;4589.678722489461;4665.46347170073;4683.063387322549;9681.66114186;9703.6118555257;9713.22294216461;9715.9028409715;9727.61089556424;5192.532672059533;5207.869803254873;5210.869728256748;5226.216067589816;5229.006488767122;4737.881552961204;4746.5490778376;4750.477447480775;4762.666613337103;4771;3705.09225239818;3740.981295093507;3748.925021499609;3781.243751249706;3794.146317078635;1219.3232755820604;1247.1955588645455;1254.6047994881583;1255.428779905141;1255.4350542256022;1365.931703414845;1373.7389895919744;1378.0973462382156;1399.979000314996;1400.4608225833128;7861.567613781182;7899.486533375312;7917.247861453268;7919.802004949807;7932.405069619802;504.50306448148547;507.68269831355406;519.3248776590493;522.2401405954328;522.4827420853404;5888;5954.285485741739;6006.069059295816;6023.45788879003;6030.728617212236;8923.196912277926;9512.2865785065;9654.71035868925;9665.371750836313;9702.320837541305;9463.763405914908;9661.903380966241;9803.460809655537;9868.111869931741;9877.357971731815;7798.922010779933;7890.7238246659945;7918.802029949182;7979.800504987422;7994.480358776661;7755.185705500841;7824.334931530883;7833.138354781084;7886.684532618631;7901.881471777813;8796.648134074565;9028.09719028092;9057.501837399006;9062.682806101755;9224.40041397307;9188.95405522968;9388.859167112361;9436.245100391814;9505.42967421957;9540.522973851419;7866.842663146591;7914.327282181079;7972.880406793786;8011.479253848481;8014.8397032057865;8019.238172373615;8075.676972921017;8090.029196496458;8092.150324216108;8100.311473524816;7419.332260096401;7478.5138965967035;7549.547027178387;7645.694172233048;7695;7367.226441223809;7416.7033318666645;7423.851522969619;7454.8509029818015;7544.094708634999;7510.098788145458;7574.697012119674;7583.848323033398;7585.0139481867;7595.5442673439775;6834.1457317835275;6867.141607299088;6924.238333783179;6930.896036559557;6937.82655433598;6977.511574189961;7017.508774385744;7026.402755765817;7026.718931242897;7041.119860017498 22:47:15 INFO - 2015-11-19 22:47:15,204 DEBUG : BROWSER_OUTPUT: |4;prototype.html;319.7713634751153;327.54961927349893;329.5254833040423;329.8565124170985;334.26461784075025;6719.73121075157;6765.120534330536;6827.487938404614;6847.897281540774;6893.586384816915;5614.624417017836;6787.830304242397;6790.219124800649;6794.830129246771;6798;4884.706917584938;4901.975490122544;5037.370328708911;5041.193409054552;5046.54581087702;4984.127777638917;5009.49905009498;5013.974930125344;5034.169362055257;5041.294218809369;4932.8407824161295;4947.554720075193;4953.529414705597;4956.653034287601;4964.280179373988;4737.976310118462;4831.734254615994;4836.588889944359;4963.0818298614695;4974.850754477371;4127.390317776069;4129.876103716893;4133.979330103361;4175.248455278049;4279.293916503804;6498.902516462257;6511.576747511396;6519.478441724651;6537.803865884031;6538.901916471256;5776.249087618625;5879.559033072536;5947.22686050815;5972.940270597325;5974.133750606138;6350.729854029212;6375.6174629522375;7046.224915259318;7144.749933752294;7191.460640451987;4779.545943135397;4797.376341075673;4807.75961201942;4836.733979631119;4841.443234028096;6263.467605253559;7643.853421986691;7721.382289416833;7725.806854828618;7750.108737495204;4759.9524004759505;4903;4910.484399138039;4912.410510738734;4927.581155601814;4986.002799440126;4998.600111991032;5008.373953255843;5008.57427118699;5013.39839219296;4771.570558649738;5937.821865344046;5950.107483877453;5954.4045595440975;5977.940220597825;7145.39264162552;7290.4167666586545;7345.669444874993;7360.153582337993;7383.040204773345;1715.4339068107495;1744.2935611077535;1745.083830988741;1745.4327343613377;1745.6159644878107;1107.1917500224881;1108.772701596171;1116.3580940958982;1125.7241975716001;1127.971800704989;6014.578979471483;6226.750929962841;6693.732250710014;6704.329567043256;6707.3292670732535;6041.365656606081;6082.482988945901;7576.052993375828;7583.2416758324825;7593.620318984029;5392.433794451526;6528.08606795049;6647.833804154935;6670.533062685662;6671.032700258435;4001.0597509585223;4042.0905296308683;4048.7773172475795;4048.8785336439955;4053.6757059435176;7915.010623672041;7973.561454120079;7979.441439099207;7982.523233201876;7983.684731427821;7738.148803631596;7988.400869934778;7998.12020677725;8033.477823941425;8035.558044307502;7646.923530764732;7791.181925897812;7795.961020194863;7809.687612495663;7966.243206895336;6198.876022479615;6958.617276049866;7696.884546731915;7729.304362607392;7732.878732583631;7287.234840341688;7596.734114305973;7602.581857997863;7607.972923655236;7613.352865006315;7932.405069619917;7937.801554961172;7945.245201705829;7949.125596184531;7950.880736788837;4699.976500117477;4741.383620129361;4747.050589881968;4749.857504274877;4753.1444340019125;7345.081864766904;7547;7564.886526702214;7586.013818203819;7594.392448604209;6115.960286751174;7257.237990010973;7297.817554561178;7358.264173582599;7394.55632662042;7350.522216056153;7357.374623157091;7362.558246505227;7365.042544469185;7379.262073792793;7014.807482728051;7183.6351093292105;7197.71209151628;7197.964010179916;7207.063081799332;7373.631318434164;7377.96311018463;7390;7397.223291554309;7397.334239918433;6990.300969902969;7177.7487787927175;7202.3877970373105;7215.350618444365;7226.927730722626 22:47:15 INFO - 2015-11-19 22:47:15,208 DEBUG : BROWSER_OUTPUT: |5;yui.html;710.5345998371066;730.7150211417545;736.269468663835;749.7001199520191;837.3092198935872;14600.196989165592;14980.700385992288;14981.700365992674;15006;15011.549653510412;11209.66371008869;13508;13570.796438053412;13587.184768913847;13598.660033499167;630.4546567219368;754.2532892436503;926.800737841364;947.9951251673214;951.7668171298008;737.8930055142001;943.3679434778714;959.0649117110831;961.3703024518951;963.8072385522923;967.042627798478;1004.3070281505737;1006.1397505133116;1007.9193664506822;1007.9344842585245;789.2344425906862;798.2177466083212;798.4291231769255;982.592224226945;999.2256001598746;584.9444302791228;588.1853632718672;595.1370512756521;725.4849057169416;743.0711610486892;14256.714865702732;14436;14447.133172009713;14448.49430269946;14477.42090316386;11923.403829808474;12151.210171338924;12381.752364952741;12388.442520086617;12448.502059917593;10000.39997600139;10042.4476653784;10050.045245701647;10123.443210623413;10689.412082335468;3435.12404336895;3537.239493508908;3539.1152211947015;3543.6102028776813;3549.503069570262;77770.6111469439;78369.04077398054;79684;79776.60111699405;79865.99999999942;9262.72211833646;9422.858657120149;9453.149216570404;9646.662366817127;9968.401895886125;20156.581210254863;20270.493237669176;20275.88482633469;20306.796932030786;20340.796592034185;7097.361237488651;7261.745838895613;7337.3029562191505;7383.8154046149275;7502.924970750222;3930.9213815723524;4169.041120542292;4169.687273454503;4192.245395828719;4208.768517731554;3550.7692000019915;3591.5151454553825;3594.1913069559664;3605.8197090145914;3609.801460919675;684.8869936460528;692.6398272898065;695.1866316409712;706.9081019467436;708.674009955416;478.35899894142017;479.4653960833645;486.16137163392864;505.6056276104644;510.79312878284355;8447.746567602982;8556.486610803371;8713.25937295337;8780.473171609723;8899.54968657592;518.8547206782107;526.147640821871;526.8383215010891;536.5439376529919;552.8175702018324;3904.39481880309;4004.3392840181627;4085.22380747657;4130.235906357333;4210.400466272453;95305.04694952961;95676;101099.49450252701;101235.97528049545;101555.98444015613;86124;86407.70388444178;86468;88705.55647221852;89366;76908.2309176901;76913;77020.61489692515;78136.82794758084;78271;8223.835523289381;8408.621612027597;8474.364422668448;8851;9034.412763170372;50236.49763502464;53145;53531.73234133804;54581;54625.63435914134;67517;67529.32470675427;71727.92408113778;77649.2235077642;78320;10688.305260158066;10886.103716111867;10983.231173817756;11412.516372871474;11424.428778561205;10538.8419173714;12111.939440302742;12165.635030949086;12356.443960021641;12958.611241662766;9693;11147.331160130418;11472.369019703996;11553.480093395985;12169.148159629096;11332.263402878787;11415.686841829662;11487.310761354345;11548.42257887119;12331.938340308241;11204.551817927191;11284.943575282072;11421.200515963803;11516.314779270553;11776.764464710486;9817.263705221994;9830.901690982999;9843.286742905377;10164.390136591828;10419.166466682798;8358.164258441073;9264.583093760932;9403.105484895881;9450.669226577036;10139.239557033105 22:47:15 INFO - 2015-11-19 22:47:15,208 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:47:15 INFO - 2015-11-19 22:47:15,208 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:47:15 INFO - 2015-11-19 22:47:15,208 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1211 22:47:15 INFO - 2015-11-19 22:47:15,208 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:47:15 INFO - 2015-11-19 22:47:15,208 DEBUG : BROWSER_OUTPUT: __startTimestamp1448002035193__endTimestamp 22:47:15 INFO - 2015-11-19 22:47:15,208 DEBUG : BROWSER_OUTPUT: 22:47:15 INFO - 2015-11-19 22:47:15,208 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:47:15 INFO - 2015-11-19 22:47:15,208 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:47:15 INFO - 2015-11-19 22:47:15,209 DEBUG : BROWSER_OUTPUT: 22:47:15 INFO - 2015-11-19 22:47:15,209 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5911.87 Median:6175.07 stddev:649.91 (10.5%) stddev-sans-first:621.94 22:47:15 INFO - 2015-11-19 22:47:15,209 DEBUG : BROWSER_OUTPUT: Values: 3425.4 3501.5 3512.1 3538.2 3555.9 5712.1 5815.9 5929.1 5990.4 6041.2 5905.3 5922.6 5947.5 6013.8 6126.9 5335.5 5367.6 5369.8 5384.1 5399.6 5470.9 5486.5 5492.4 5493.1 5515.7 4334.0 5204.6 5359.5 5426.8 5485.3 5392.4 5402.8 5419.6 5422.0 5430.2 5244.9 5320.4 5398.0 5399.1 5404.5 5857.5 5904.0 5958.7 5966.1 6002.4 6334.0 6358.3 6361.3 6362.5 6364.3 6130.9 6170.2 6260.0 6424.1 6444.8 5999.4 6046.0 6094.8 6106.5 6134.7 6441.9 6444.5 6502.6 6517.2 6530.5 6120.3 6252.8 6259.2 6313.2 6334.0 6285.5 6387.3 6403.2 6405.1 6407.8 6291.1 6296.2 6302.4 6308.2 6313.0 6183.4 6295.1 6298.3 6309.1 6348.1 5016.3 5029.8 5068.9 5078.0 5124.3 4565.1 4594.4 4606.4 4608.0 4631.4 4944.2 5755.9 5894.2 6039.4 6048.8 6253.7 6333.5 6346.1 6356.9 6362.6 5963.9 5968.6 5973.7 5978.6 5990.3 5400.3 5505.6 5520.9 5524.4 5583.0 6325.9 6388.2 6430.3 6443.1 6452.0 6377.9 6410.8 6433.3 6437.4 6461.8 6538.9 6562.5 6585.6 6591.8 6595.5 6187.4 6206.6 6307.9 6334.4 6341.6 6351.2 6383.1 6384.7 6409.6 6411.1 6146.6 6262.7 6312.8 6316.6 6340.7 6124.7 6214.8 6230.4 6241.4 6309.8 6124.7 6133.4 6175.1 6192.9 6241.7 6286.6 6312.8 6324.4 6325.0 6333.8 6218.7 6265.4 6285.2 6291.7 6299.2 22:47:15 INFO - 2015-11-19 22:47:15,209 DEBUG : BROWSER_OUTPUT: 22:47:15 INFO - 2015-11-19 22:47:15,209 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:65525.84 Median:38119.03 stddev:133304.59 (349.7%) stddev-sans-first:133589.29 22:47:15 INFO - 2015-11-19 22:47:15,210 DEBUG : BROWSER_OUTPUT: Values: 554.1 554.4 588.7 588.9 598.9 24669.9 32188.0 39664.0 39949.6 40164.8 35344.5 43311.1 43605.6 43692.3 43703.0 9716.1 9915.9 9919.6 9929.7 9933.9 8897.9 9013.3 9013.9 9019.4 9025.4 8874.9 11780.5 11898.1 11904.3 11918.3 11753.5 11789.2 11801.0 11812.6 11816.0 8887.2 9020.0 11545.2 11698.3 11723.8 31999.0 42775.1 42864.4 42899.8 43076.1 3213.9 3295.4 3488.9 3729.0 4067.5 28171.6 28302.9 28857.4 29109.3 29125.9 2791.7 2858.2 2878.3 2881.2 2904.0 505967.0 508247.0 509401.5 509596.0 510380.0 57459.4 70020.0 70372.9 70478.6 70596.6 71668.0 71871.0 71876.6 71902.6 72049.0 16506.6 16882.2 16904.7 16912.9 16958.8 12787.0 12867.4 12889.7 12893.9 12894.3 16728.7 21251.0 21483.5 21709.7 21736.2 9504.7 9743.0 9766.8 9786.0 9803.3 849.4 965.3 1059.8 1079.4 1111.4 29472.7 29666.4 29878.9 30231.0 30296.4 1028.2 1069.7 1136.0 1186.6 1212.0 14815.3 14822.3 15068.2 15204.9 15353.3 536504.0 541268.0 542206.0 542588.0 543288.6 50878.2 51146.7 51177.7 62235.4 62243.0 1268.2 1476.3 1505.0 1506.2 1535.1 28154.4 31206.0 31889.0 31932.0 32648.7 56405.7 57126.0 57158.7 57167.0 57170.7 448369.3 449168.0 452023.0 453495.0 453948.0 32559.7 33975.7 34687.7 44957.6 46922.5 46719.3 46963.8 48004.5 48289.5 48335.3 29414.9 37460.1 38987.4 39823.6 41099.0 31224.0 37631.0 38396.8 39128.4 39412.0 37841.2 38419.2 38973.8 39002.2 39095.0 32364.8 34905.8 34968.7 35391.0 35850.5 25109.6 25269.9 25277.9 25396.7 25625.5 22:47:15 INFO - 2015-11-19 22:47:15,210 DEBUG : BROWSER_OUTPUT: 22:47:15 INFO - 2015-11-19 22:47:15,211 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:37755.93 Median:11311.41 stddev:119997.53 (1060.9%) stddev-sans-first:120301.30 22:47:15 INFO - 2015-11-19 22:47:15,212 DEBUG : BROWSER_OUTPUT: Values: 357.3 359.2 363.9 365.3 369.5 16201.8 17848.9 19770.3 20597.6 21303.6 20269.9 20278.5 20756.8 20757.1 20777.2 4040.5 5281.2 5422.3 5427.3 5439.0 4115.4 4145.0 5849.8 6037.3 6054.8 5943.5 6030.8 6048.9 6054.3 6575.8 6546.4 6563.6 6572.3 6579.7 6593.0 4714.5 5464.5 5625.7 5628.4 5693.2 12417.7 12785.5 12832.9 12852.6 12870.4 1911.8 1970.2 2010.3 2051.2 2069.1 8684.0 9783.6 9981.4 10010.5 10154.5 1698.3 1721.8 1727.1 1735.8 1735.9 90043.0 95047.5 96407.0 96528.0 97303.5 11058.8 11116.9 11130.9 11139.9 11192.0 13156.0 13188.3 13191.3 13195.7 13199.4 8405.0 8464.9 8467.0 8514.2 8548.9 8688.0 8704.7 8727.0 8827.6 8840.8 3790.6 4294.1 4336.4 4342.2 4375.2 1750.3 1777.7 1789.1 1790.5 1790.9 900.7 938.9 947.2 1058.9 1095.6 19439.4 20359.5 21262.8 21323.9 21606.4 932.8 986.8 992.4 1014.2 1049.8 10973.7 11519.8 11716.3 11755.1 11807.2 716911.0 718872.0 728637.0 734232.0 747886.0 91031.5 122995.8 123520.0 123573.0 127108.0 1230.9 1231.5 1235.4 1239.5 1260.8 15533.5 17490.8 19007.7 19021.9 19334.5 50046.7 50442.5 50512.0 50572.2 51152.0 69641.8 70420.0 70970.2 71110.3 74823.6 10016.5 10128.9 10149.1 10406.8 10490.6 11926.3 13782.8 20571.6 20966.9 21294.9 11833.9 14379.8 16477.5 16754.8 16797.8 12400.0 12675.6 15823.8 16464.2 16540.9 16183.3 16910.7 17016.0 17020.1 17053.0 9702.3 9978.8 10000.9 10070.7 10148.5 10314.9 12576.4 15998.4 16498.3 17033.9 22:47:15 INFO - 2015-11-19 22:47:15,212 DEBUG : BROWSER_OUTPUT: 22:47:15 INFO - 2015-11-19 22:47:15,213 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5812.54 Median:6850.64 stddev:3022.80 (44.1%) stddev-sans-first:3012.52 22:47:15 INFO - 2015-11-19 22:47:15,213 DEBUG : BROWSER_OUTPUT: Values: 1332.3 1566.3 1568.1 1850.9 1868.1 7450.6 7601.2 7614.5 8055.2 8348.7 8158.1 8192.8 8346.0 8358.7 8361.4 2356.0 2389.7 2389.9 2390.3 2391.2 2360.4 2415.5 2421.8 2423.9 2424.9 2036.5 2198.6 2368.1 2383.3 2387.8 2321.4 2358.6 2364.8 2374.2 2374.7 2364.4 2390.7 2406.4 2409.8 2411.7 8281.0 8353.0 8358.8 8362.6 8392.0 4620.2 4783.8 4811.1 5069.8 5228.9 3493.7 3512.6 3533.9 3539.8 3568.5 1032.5 1032.6 1043.1 1053.8 1057.6 10911.5 10986.2 11016.4 11025.0 11028.4 3918.9 4478.2 4589.7 4665.5 4683.1 9681.7 9703.6 9713.2 9715.9 9727.6 5192.5 5207.9 5210.9 5226.2 5229.0 4737.9 4746.5 4750.5 4762.7 4771.0 3705.1 3741.0 3748.9 3781.2 3794.1 1219.3 1247.2 1254.6 1255.4 1255.4 1365.9 1373.7 1378.1 1400.0 1400.5 7861.6 7899.5 7917.2 7919.8 7932.4 504.5 507.7 519.3 522.2 522.5 5888.0 5954.3 6006.1 6023.5 6030.7 8923.2 9512.3 9654.7 9665.4 9702.3 9463.8 9661.9 9803.5 9868.1 9877.4 7798.9 7890.7 7918.8 7979.8 7994.5 7755.2 7824.3 7833.1 7886.7 7901.9 8796.6 9028.1 9057.5 9062.7 9224.4 9189.0 9388.9 9436.2 9505.4 9540.5 7866.8 7914.3 7972.9 8011.5 8014.8 8019.2 8075.7 8090.0 8092.2 8100.3 7419.3 7478.5 7549.5 7645.7 7695.0 7367.2 7416.7 7423.9 7454.9 7544.1 7510.1 7574.7 7583.8 7585.0 7595.5 6834.1 6867.1 6924.2 6930.9 6937.8 6977.5 7017.5 7026.4 7026.7 7041.1 22:47:15 INFO - 2015-11-19 22:47:15,213 DEBUG : BROWSER_OUTPUT: 22:47:15 INFO - 2015-11-19 22:47:15,214 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5936.13 Median:6538.35 stddev:1898.97 (29.0%) stddev-sans-first:1856.92 22:47:15 INFO - 2015-11-19 22:47:15,214 DEBUG : BROWSER_OUTPUT: Values: 319.8 327.5 329.5 329.9 334.3 6719.7 6765.1 6827.5 6847.9 6893.6 5614.6 6787.8 6790.2 6794.8 6798.0 4884.7 4902.0 5037.4 5041.2 5046.5 4984.1 5009.5 5014.0 5034.2 5041.3 4932.8 4947.6 4953.5 4956.7 4964.3 4738.0 4831.7 4836.6 4963.1 4974.9 4127.4 4129.9 4134.0 4175.2 4279.3 6498.9 6511.6 6519.5 6537.8 6538.9 5776.2 5879.6 5947.2 5972.9 5974.1 6350.7 6375.6 7046.2 7144.7 7191.5 4779.5 4797.4 4807.8 4836.7 4841.4 6263.5 7643.9 7721.4 7725.8 7750.1 4760.0 4903.0 4910.5 4912.4 4927.6 4986.0 4998.6 5008.4 5008.6 5013.4 4771.6 5937.8 5950.1 5954.4 5977.9 7145.4 7290.4 7345.7 7360.2 7383.0 1715.4 1744.3 1745.1 1745.4 1745.6 1107.2 1108.8 1116.4 1125.7 1128.0 6014.6 6226.8 6693.7 6704.3 6707.3 6041.4 6082.5 7576.1 7583.2 7593.6 5392.4 6528.1 6647.8 6670.5 6671.0 4001.1 4042.1 4048.8 4048.9 4053.7 7915.0 7973.6 7979.4 7982.5 7983.7 7738.1 7988.4 7998.1 8033.5 8035.6 7646.9 7791.2 7796.0 7809.7 7966.2 6198.9 6958.6 7696.9 7729.3 7732.9 7287.2 7596.7 7602.6 7608.0 7613.4 7932.4 7937.8 7945.2 7949.1 7950.9 4700.0 4741.4 4747.1 4749.9 4753.1 7345.1 7547.0 7564.9 7586.0 7594.4 6116.0 7257.2 7297.8 7358.3 7394.6 7350.5 7357.4 7362.6 7365.0 7379.3 7014.8 7183.6 7197.7 7198.0 7207.1 7373.6 7378.0 7390.0 7397.2 7397.3 6990.3 7177.7 7202.4 7215.4 7226.9 22:47:15 INFO - 2015-11-19 22:47:15,214 DEBUG : BROWSER_OUTPUT: 22:47:15 INFO - 2015-11-19 22:47:15,214 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19076.68 Median:522.50 stddev:27562.19 (5275.0%) stddev-sans-first:27605.01 22:47:15 INFO - 2015-11-19 22:47:15,216 DEBUG : BROWSER_OUTPUT: Values: 710.5 730.7 736.3 749.7 837.3 14600.2 14980.7 14981.7 15006.0 15011.5 11209.7 13508.0 13570.8 13587.2 13598.7 630.5 754.3 926.8 948.0 951.8 737.9 943.4 959.1 961.4 963.8 967.0 1004.3 1006.1 1007.9 1007.9 789.2 798.2 798.4 982.6 999.2 584.9 588.2 595.1 725.5 743.1 14256.7 14436.0 14447.1 14448.5 14477.4 11923.4 12151.2 12381.8 12388.4 12448.5 10000.4 10042.4 10050.0 10123.4 10689.4 3435.1 3537.2 3539.1 3543.6 3549.5 77770.6 78369.0 79684.0 79776.6 79866.0 9262.7 9422.9 9453.1 9646.7 9968.4 20156.6 20270.5 20275.9 20306.8 20340.8 7097.4 7261.7 7337.3 7383.8 7502.9 3930.9 4169.0 4169.7 4192.2 4208.8 3550.8 3591.5 3594.2 3605.8 3609.8 684.9 692.6 695.2 706.9 708.7 478.4 479.5 486.2 505.6 510.8 8447.7 8556.5 8713.3 8780.5 8899.5 518.9 526.1 526.8 536.5 552.8 3904.4 4004.3 4085.2 4130.2 4210.4 95305.0 95676.0 101099.5 101236.0 101556.0 86124.0 86407.7 86468.0 88705.6 89366.0 76908.2 76913.0 77020.6 78136.8 78271.0 8223.8 8408.6 8474.4 8851.0 9034.4 50236.5 53145.0 53531.7 54581.0 54625.6 67517.0 67529.3 71727.9 77649.2 78320.0 10688.3 10886.1 10983.2 11412.5 11424.4 10538.8 12111.9 12165.6 12356.4 12958.6 9693.0 11147.3 11472.4 11553.5 12169.1 11332.3 11415.7 11487.3 11548.4 12331.9 11204.6 11284.9 11421.2 11516.3 11776.8 9817.3 9830.9 9843.3 10164.4 10419.2 8358.2 9264.6 9403.1 9450.7 10139.2 22:47:15 INFO - 2015-11-19 22:47:15,216 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:47:15 INFO - 2015-11-19 22:47:15,216 DEBUG : BROWSER_OUTPUT: 22:47:15 INFO - 2015-11-19 22:47:15,629 INFO : Browser exited with error code: 0 22:47:15 INFO - 2015-11-19 22:47:15,654 INFO : Completed test dromaeo_css (00:18:33) 22:47:15 INFO - 2015-11-19 22:47:15,654 INFO : Starting test kraken 22:47:15 INFO - 2015-11-19 22:47:15,654 DEBUG : operating with platform_type : mac_ 22:47:15 INFO - 2015-11-19 22:47:15,654 INFO : Initialising browser for kraken test... 22:47:15 INFO - 2015-11-19 22:47:15,667 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/tmpRyg_Ji/profile http://localhost:49392/getInfo.html 22:47:17 INFO - 2015-11-19 22:47:17,666 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:47:17 INFO - 2015-11-19 22:47:17,666 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:47:17 INFO - 2015-11-19 22:47:17,666 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:47:17 INFO - 2015-11-19 22:47:17,667 DEBUG : BROWSER_OUTPUT: __metrics 22:47:17 INFO - 2015-11-19 22:47:17,684 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:47:18 INFO - 2015-11-19 22:47:18,344 INFO : Browser initialized. 22:47:18 INFO - 2015-11-19 22:47:18,344 INFO : Running cycle 1/1 for kraken test... 22:47:18 INFO - 2015-11-19 22:47:18,344 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/tmpRyg_Ji/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:47:30 INFO - 2015-11-19 22:47:30,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 225796096 22:47:30 INFO - 2015-11-19 22:47:30,113 DEBUG : BROWSER_OUTPUT: 22:47:32 INFO - 2015-11-19 22:47:32,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-beat-detection) 22:47:33 INFO - 2015-11-19 22:47:33,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 275513344 22:47:33 INFO - 2015-11-19 22:47:33,214 DEBUG : BROWSER_OUTPUT: 22:47:35 INFO - 2015-11-19 22:47:35,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-dft) 22:47:36 INFO - 2015-11-19 22:47:36,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 290037760 22:47:36 INFO - 2015-11-19 22:47:36,336 DEBUG : BROWSER_OUTPUT: 22:47:39 INFO - 2015-11-19 22:47:39,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-fft) 22:47:40 INFO - 2015-11-19 22:47:40,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 276267008 22:47:40 INFO - 2015-11-19 22:47:40,102 DEBUG : BROWSER_OUTPUT: 22:47:41 INFO - 2015-11-19 22:47:41,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49392/tests/kraken/driver.html?testName=audio-oscillator) 22:47:42 INFO - 2015-11-19 22:47:42,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 276598784 22:47:42 INFO - 2015-11-19 22:47:42,537 DEBUG : BROWSER_OUTPUT: 22:47:44 INFO - 2015-11-19 22:47:44,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:47:45 INFO - 2015-11-19 22:47:45,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 279818240 22:47:45 INFO - 2015-11-19 22:47:45,098 DEBUG : BROWSER_OUTPUT: 22:47:47 INFO - 2015-11-19 22:47:47,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-darkroom) 22:47:48 INFO - 2015-11-19 22:47:48,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 280616960 22:47:48 INFO - 2015-11-19 22:47:48,355 DEBUG : BROWSER_OUTPUT: 22:47:51 INFO - 2015-11-19 22:47:51,111 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49392/tests/kraken/driver.html?testName=imaging-desaturate) 22:47:51 INFO - 2015-11-19 22:47:51,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 280674304 22:47:51 INFO - 2015-11-19 22:47:51,695 DEBUG : BROWSER_OUTPUT: 22:47:54 INFO - 2015-11-19 22:47:54,370 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49392/tests/kraken/driver.html?testName=json-parse-financial) 22:47:54 INFO - 2015-11-19 22:47:54,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 280911872 22:47:54 INFO - 2015-11-19 22:47:54,958 DEBUG : BROWSER_OUTPUT: 22:47:56 INFO - 2015-11-19 22:47:56,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49392/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:47:57 INFO - 2015-11-19 22:47:57,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 312913920 22:47:57 INFO - 2015-11-19 22:47:57,056 DEBUG : BROWSER_OUTPUT: 22:47:58 INFO - 2015-11-19 22:47:58,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:47:59 INFO - 2015-11-19 22:47:59,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 315793408 22:47:59 INFO - 2015-11-19 22:47:59,476 DEBUG : BROWSER_OUTPUT: 22:48:01 INFO - 2015-11-19 22:48:01,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:48:02 INFO - 2015-11-19 22:48:02,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 322555904 22:48:02 INFO - 2015-11-19 22:48:02,092 DEBUG : BROWSER_OUTPUT: 22:48:04 INFO - 2015-11-19 22:48:04,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:48:05 INFO - 2015-11-19 22:48:05,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 323977216 22:48:05 INFO - 2015-11-19 22:48:05,160 DEBUG : BROWSER_OUTPUT: 22:48:07 INFO - 2015-11-19 22:48:07,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:48:08 INFO - 2015-11-19 22:48:08,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 324022272 22:48:08 INFO - 2015-11-19 22:48:08,119 DEBUG : BROWSER_OUTPUT: 22:48:09 INFO - 2015-11-19 22:48:09,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49392/tests/kraken/driver.html?testName=ai-astar) 22:48:10 INFO - 2015-11-19 22:48:10,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 383193088 22:48:10 INFO - 2015-11-19 22:48:10,035 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,035 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:48:10 INFO - 2015-11-19 22:48:10,036 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:48:10 INFO - 2015-11-19 22:48:10,037 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:48:10 INFO - 2015-11-19 22:48:10,037 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:48:10 INFO - 2015-11-19 22:48:10,037 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;105;110;110;110;110;110;102;109 22:48:10 INFO - 2015-11-19 22:48:10,037 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;164;145;141;153;115;141;138;111;153;117 22:48:10 INFO - 2015-11-19 22:48:10,037 DEBUG : BROWSER_OUTPUT: |2;audio-dft;182;181;183;183;184;184;185;185;184;180 22:48:10 INFO - 2015-11-19 22:48:10,037 DEBUG : BROWSER_OUTPUT: |3;audio-fft;59;70;72;70;56;56;56;68;72;55 22:48:10 INFO - 2015-11-19 22:48:10,037 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;82;85;114;73;74;74;111;74;75;113 22:48:10 INFO - 2015-11-19 22:48:10,037 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;85;87;85;86;86;88;86;86;86;86 22:48:10 INFO - 2015-11-19 22:48:10,037 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;94;95;94;95;98;95;95;93;94;94 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;86;86;86;85;87;85;87;87;86;86 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;55;56;54;55;55;54;65;52;53 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;63;64;66;65;67;76;69 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;81;80;81;82;82;83;83;83 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;123;119;119;118;118;118;121;117;125;135 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;125;135;135;136;119;135;134;137;125 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;63;65;66;64;64;66;90;62;53 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1040 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: __startTimestamp1448002090035__endTimestamp 22:48:10 INFO - 2015-11-19 22:48:10,038 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,046 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:48:10 INFO - 2015-11-19 22:48:10,046 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:48:10 INFO - 2015-11-19 22:48:10,046 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,046 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:2.80 (2.5%) stddev-sans-first:2.92 22:48:10 INFO - 2015-11-19 22:48:10,046 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 105.0 110.0 110.0 110.0 110.0 110.0 102.0 109.0 22:48:10 INFO - 2015-11-19 22:48:10,046 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,046 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:137.80 Median:143.00 stddev:17.92 (12.5%) stddev-sans-first:16.31 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: Values: 164.0 145.0 141.0 153.0 115.0 141.0 138.0 111.0 153.0 117.0 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:183.10 Median:184.00 stddev:1.66 (0.9%) stddev-sans-first:1.72 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: Values: 182.0 181.0 183.0 183.0 184.0 184.0 185.0 185.0 184.0 180.0 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:63.40 Median:69.00 stddev:7.53 (10.9%) stddev-sans-first:7.82 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: Values: 59.0 70.0 72.0 70.0 56.0 56.0 56.0 68.0 72.0 55.0 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:87.50 Median:74.00 stddev:17.81 (24.1%) stddev-sans-first:18.78 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: Values: 82.0 85.0 114.0 73.0 74.0 74.0 111.0 74.0 75.0 113.0 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:86.00 stddev:0.88 (1.0%) stddev-sans-first:0.83 22:48:10 INFO - 2015-11-19 22:48:10,047 DEBUG : BROWSER_OUTPUT: Values: 85.0 87.0 85.0 86.0 86.0 88.0 86.0 86.0 86.0 86.0 22:48:10 INFO - 2015-11-19 22:48:10,048 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,048 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:1.34 (1.4%) stddev-sans-first:1.39 22:48:10 INFO - 2015-11-19 22:48:10,048 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 94.0 95.0 98.0 95.0 95.0 93.0 94.0 94.0 22:48:10 INFO - 2015-11-19 22:48:10,048 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,048 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 22:48:10 INFO - 2015-11-19 22:48:10,048 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 86.0 85.0 87.0 85.0 87.0 87.0 86.0 86.0 22:48:10 INFO - 2015-11-19 22:48:10,048 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,048 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:3.60 (6.5%) stddev-sans-first:3.78 22:48:10 INFO - 2015-11-19 22:48:10,048 DEBUG : BROWSER_OUTPUT: Values: 57.0 55.0 56.0 54.0 55.0 55.0 54.0 65.0 52.0 53.0 22:48:10 INFO - 2015-11-19 22:48:10,048 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,048 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:65.50 stddev:4.03 (6.1%) stddev-sans-first:4.12 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 63.0 64.0 66.0 65.0 67.0 76.0 69.0 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.99 (1.2%) stddev-sans-first:1.05 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 81.0 80.0 81.0 82.0 82.0 83.0 83.0 83.0 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:120.00 stddev:5.44 (4.5%) stddev-sans-first:5.73 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: Values: 123.0 119.0 119.0 118.0 118.0 118.0 121.0 117.0 125.0 135.0 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.80 Median:135.00 stddev:6.36 (4.7%) stddev-sans-first:6.46 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: Values: 137.0 125.0 135.0 135.0 136.0 119.0 135.0 134.0 137.0 125.0 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,049 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:65.00 stddev:9.31 (14.3%) stddev-sans-first:9.87 22:48:10 INFO - 2015-11-19 22:48:10,050 DEBUG : BROWSER_OUTPUT: Values: 65.0 63.0 65.0 66.0 64.0 64.0 66.0 90.0 62.0 53.0 22:48:10 INFO - 2015-11-19 22:48:10,050 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:48:10 INFO - 2015-11-19 22:48:10,050 DEBUG : BROWSER_OUTPUT: 22:48:10 INFO - 2015-11-19 22:48:10,773 INFO : Browser exited with error code: 0 22:48:10 INFO - 2015-11-19 22:48:10,818 INFO : Completed test kraken (00:00:55) 22:48:10 INFO - 2015-11-19 22:48:10,818 INFO : Starting test v8_7 22:48:10 INFO - 2015-11-19 22:48:10,818 DEBUG : operating with platform_type : mac_ 22:48:10 INFO - 2015-11-19 22:48:10,818 INFO : Initialising browser for v8_7 test... 22:48:10 INFO - 2015-11-19 22:48:10,831 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/tmpKpWzz6/profile http://localhost:49392/getInfo.html 22:48:12 INFO - 2015-11-19 22:48:12,728 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:48:12 INFO - 2015-11-19 22:48:12,729 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:48:12 INFO - 2015-11-19 22:48:12,729 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 22:48:12 INFO - 2015-11-19 22:48:12,729 DEBUG : BROWSER_OUTPUT: __metrics 22:48:12 INFO - 2015-11-19 22:48:12,746 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:48:13 INFO - 2015-11-19 22:48:13,381 INFO : Browser initialized. 22:48:13 INFO - 2015-11-19 22:48:13,382 INFO : Running cycle 1/1 for v8_7 test... 22:48:13 INFO - 2015-11-19 22:48:13,382 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/tmpKpWzz6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:48:25 INFO - 2015-11-19 22:48:25,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 226127872 22:48:25 INFO - 2015-11-19 22:48:25,299 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,652 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49392/tests/v8_7/run.html (next: http://localhost:49392/tests/v8_7/run.html) 22:48:46 INFO - 2015-11-19 22:48:46,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 699813888 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: |0;Richards;147.90711433219937 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;160.74586079408456 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.08744710860367 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4758.293838862559 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1697.792869269949 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: |5;Earley;798.7220447284345 22:48:46 INFO - 2015-11-19 22:48:46,914 DEBUG : BROWSER_OUTPUT: |6;Boyer;12382.716049382716 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: |7;RegExp;27540.54054054054 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: |8;Splay;610.1281269066504 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4522.522522522522 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: __startTimestamp1448002126909__endTimestamp 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:147.91 Median:147.91 stddev:0.00 (0.0%) 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: Values: 147.9 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:160.75 Median:160.75 stddev:0.00 (0.0%) 22:48:46 INFO - 2015-11-19 22:48:46,915 DEBUG : BROWSER_OUTPUT: Values: 160.7 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.09 Median:282.09 stddev:0.00 (0.0%) 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: Values: 282.1 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4758.29 Median:4758.29 stddev:0.00 (0.0%) 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: Values: 4758.3 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1697.79 Median:1697.79 stddev:0.00 (0.0%) 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: Values: 1697.8 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:798.72 Median:798.72 stddev:0.00 (0.0%) 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: Values: 798.7 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,916 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: Values: 12382.7 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27540.54 Median:27540.54 stddev:0.00 (0.0%) 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: Values: 27540.5 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.13 Median:610.13 stddev:0.00 (0.0%) 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: Values: 610.1 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4522.52 Median:4522.52 stddev:0.00 (0.0%) 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: Values: 4522.5 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:48:46 INFO - 2015-11-19 22:48:46,917 DEBUG : BROWSER_OUTPUT: 22:48:47 INFO - 2015-11-19 22:48:47,566 INFO : Browser exited with error code: 0 22:48:47 INFO - 2015-11-19 22:48:47,583 INFO : Completed test v8_7 (00:00:36) 22:48:48 INFO - 2015-11-19 22:48:48,041 INFO : Completed test suite (00:20:05) 22:48:48 INFO - 2015-11-19 22:48:48,041 DEBUG : Working with test: dromaeo_css 22:48:48 INFO - 2015-11-19 22:48:48,042 DEBUG : Generating results file: dromaeo_css 22:48:48 INFO - 2015-11-19 22:48:48,042 DEBUG : Working with test: kraken 22:48:48 INFO - 2015-11-19 22:48:48,042 DEBUG : Generating results file: kraken 22:48:48 INFO - 2015-11-19 22:48:48,043 INFO : javascript benchmark 22:48:48 INFO - 2015-11-19 22:48:48,043 DEBUG : Working with test: v8_7 22:48:48 INFO - 2015-11-19 22:48:48,043 DEBUG : Generating results file: v8_7 22:48:48 INFO - 2015-11-19 22:48:48,043 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:48:48 INFO - 2015-11-19 22:48:48,550 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 22:48:48 INFO - 2015-11-19 22:48:48,551 DEBUG : process_Request line: dromaeo_css 7674.00 graph.html#tests=[[72,64,59]] 22:48:48 INFO - 2015-11-19 22:48:48,551 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:48:48 INFO - 2015-11-19 22:48:48,575 DEBUG : process_Request line: kraken 1369.70 graph.html#tests=[[232,64,59]] 22:48:48 INFO - 2015-11-19 22:48:48,575 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:48:48 INFO - 2015-11-19 22:48:48,600 DEBUG : process_Request line: v8_7 20819.45 graph.html#tests=[[230,64,59]] 22:48:48 INFO - 2015-11-19 22:48:48,601 INFO : javascript benchmark 22:48:48 INFO - 2015-11-19 22:48:48,603 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3425.417678994571, 3501.474778783182, 3512.086857417072, 3538.221591249924, 3555.875544355948, 5712.086066229404, 5815.941840581593, 5929.110633404992, 5990.4309090636425, 6041.1542384066215, 5905.291365036202, 5922.585419020659, 5947.524198064155, 6013.759449622021, 6126.908096378546, 5335.5198032177095, 5367.570594352462, 5369.785208591671, 5384.057789886774, 5399.649022813504, 5470.9452905471035, 5486.533644640211, 5492.395836457987, 5493.121100623901, 5515.696636684981, 4334.0, 5204.583633309327, 5359.490848369399, 5426.810061647843, 5485.341758988927, 5392.40683524812, 5402.8109016184635, 5419.566434685215, 5422.0, 5430.185472179205, 5244.947550524484, 5320.361556613192, 5398.0, 5399.136138217906, 5404.51359377654, 5857.502112320458, 5903.996320625504, 5958.702064896781, 5966.134910437962, 6002.429769171922, 6334.0, 6358.33237510064, 6361.332060133665, 6362.459190968773, 6364.2681091674585, 6130.908036379458, 6170.19787427636, 6260.0, 6424.100625912376, 6444.806655800334, 5999.370066143079, 6045.993880128394, 6094.849668001284, 6106.45041946218, 6134.723937422782, 6441.935580644227, 6444.516661250425, 6502.642354670444, 6517.217933847968, 6530.510211734044, 6120.314383336517, 6252.781152659635, 6259.217597800275, 6313.179286692793, 6334.0, 6285.528585356116, 6387.297397286295, 6403.167588213502, 6405.135306733625, 6407.775727849503, 6291.1192433059405, 6296.150019747275, 6302.369763023753, 6308.179936608211, 6313.021481670348, 6183.3816618337805, 6295.087212354275, 6298.307186209513, 6309.14826498426, 6348.079528468346, 5016.347874776256, 5029.798808047711, 5068.898622027539, 5077.974610126926, 5124.333836601292, 4565.086982603492, 4594.402727645452, 4606.447226332862, 4608.009278005245, 4631.3516107744945, 4944.208926571731, 5755.8561035974435, 5894.233749612608, 6039.4262545058145, 6048.848778780566, 6253.6560489173535, 6333.46165575922, 6346.079818426395, 6356.919323714979, 6362.618242905441, 5963.850903727442, 5968.552358573124, 5973.701314934323, 5978.641281523122, 5990.251218597676, 5400.270963419888, 5505.587080968943, 5520.861978450571, 5524.392316845144, 5582.97208513963, 6325.936740632719, 6388.201474815648, 6430.324815894263, 6443.065755465525, 6451.967740161269, 6377.936220637735, 6410.775622853178, 6433.260175079926, 6437.356264373525, 6461.8061458156335, 6538.869222615426, 6562.507811914221, 6585.5719378240265, 6591.835204119935, 6595.472362211108, 6187.412195841388, 6206.565540412128, 6307.873842523216, 6334.3665633436285, 6341.55609107358, 6351.174347334817, 6383.138276332821, 6384.744610215539, 6409.583377080475, 6411.070394792822, 6146.569740118149, 6262.686865656608, 6312.810615681537, 6316.62100273985, 6340.651264180515, 6124.724387402489, 6214.751409943552, 6230.376962303733, 6241.375862413723, 6309.842253943688, 6124.693765311806, 6133.355997620186, 6175.073738939015, 6192.907106393498, 6241.719122639583, 6286.5599408041, 6312.842178945563, 6324.430801227728, 6325.0, 6333.841653958688, 6218.657973811484, 6265.4361107500545, 6285.214348206474, 6291.653959032297, 6299.212598425197], "unit": "ms", "name": "dojo.html", "value": 5870.902867023225}, {"lowerIsBetter": false, "replicates": [554.0719295180572, 554.373557879596, 588.7468388592903, 588.9310900715199, 598.9099838294305, 24669.876650616745, 32188.0, 39664.0, 39949.60050399495, 40164.799176004155, 35344.46983295253, 43311.13377732444, 43605.56394436055, 43692.3446148308, 43703.0, 9716.125548700633, 9915.900840991606, 9919.553620087114, 9929.702108936708, 9933.900660993406, 8897.866532002025, 9013.324000699973, 9013.864792028126, 9019.413738107001, 9025.368224224307, 8874.86687699685, 11780.469878855472, 11898.107641926847, 11904.285742855413, 11918.28490290581, 11753.529858805638, 11789.233699809485, 11801.0, 11812.586559470463, 11816.0, 8887.200151986352, 9019.954900225457, 11545.249558778652, 11698.2981021139, 11723.765524689543, 31999.0, 42775.14449710988, 42864.357034644505, 42899.785501072605, 43076.13847723059, 3213.935721285585, 3295.40682677118, 3488.947665785015, 3728.9627103728885, 4067.5322337930925, 28171.619405671245, 28302.858485707646, 28857.422851543062, 29109.272268193254, 29125.854370728222, 2791.6929137794828, 2858.1854171561004, 2878.280429892527, 2881.150060732089, 2904.0, 505967.0, 508247.0, 509401.45299273636, 509596.0, 510380.0, 57459.425405746246, 70020.0, 70372.94440583396, 70478.64760676163, 70596.64701676561, 71668.0, 71871.0, 71876.64061679658, 71902.64048679723, 72049.0, 16506.58733531647, 16882.15589220534, 16904.746428803577, 16912.915435422743, 16958.830411695973, 12787.040971927143, 12867.42096605655, 12889.742205156032, 12893.871061289266, 12894.29081400532, 16728.749068763977, 21251.0, 21483.46291342729, 21709.67435488469, 21736.239231626816, 9504.667336643184, 9742.951285243671, 9766.804663906682, 9785.951070244602, 9803.313768036169, 849.4308813095241, 965.2760429677742, 1059.750958524746, 1079.3685693869174, 1111.3998440841856, 29472.705272946994, 29666.406671866873, 29878.850605746833, 30231.0, 30296.394072118434, 1028.2391030637425, 1069.7165251208437, 1135.994320028411, 1186.5609724402027, 1211.9697007574882, 14815.259237038104, 14822.332995015251, 15068.246587670572, 15204.923975380274, 15353.309101090477, 536504.0, 541268.0, 542206.0, 542588.0, 543288.5671143318, 50878.23682644763, 51146.721331966255, 51177.74411127921, 62235.37764622386, 62243.0, 1268.1566758105942, 1476.2840022589037, 1505.0442968714945, 1506.1791323728814, 1535.109636410879, 28154.43691126207, 31206.0, 31889.0, 31932.0, 32648.673513264563, 56405.71797140988, 57126.0, 57158.7142064287, 57167.0, 57170.714146429, 448369.3070742508, 449168.0, 452023.0, 453495.0, 453948.0, 32559.674403255663, 33975.66024339824, 34687.653123468444, 44957.55042449533, 46922.53077469318, 46719.29921051119, 46963.765181175244, 48004.5199548014, 48289.517104828505, 48335.27497087617, 29414.852925735235, 37460.06349841276, 38987.41518877162, 39823.60176398199, 41099.0, 31224.0, 37631.0, 38396.80801596086, 39128.41307380335, 39412.0, 37841.24317513689, 38419.231615366974, 38973.8051309753, 39002.219955600165, 39095.02262443462, 32364.83817580897, 34905.825470872485, 34968.65031349654, 35391.0, 35850.46224306586, 25109.623355650045, 25269.87365063163, 25277.87361063183, 25396.746032540177, 25625.487490250463], "unit": "ms", "name": "ext.html", "value": 20644.71398654927}, {"lowerIsBetter": false, "replicates": [357.3371396060308, 359.20436233742265, 363.870825856821, 365.27675203097857, 369.48272418613936, 16201.756973645404, 17848.910755446235, 19770.30803921863, 20597.588048239046, 21303.57392852144, 20269.898650506726, 20278.493037674067, 20756.792432075676, 20757.065932033056, 20777.16891324349, 4040.5353384360733, 5281.155015197579, 5422.267993820843, 5427.3215848019, 5438.972805135969, 4115.444415003981, 4145.0, 5849.824505264827, 6037.305709843358, 6054.8183554493435, 5943.524518038546, 6030.849228769272, 6048.909266361008, 6054.303755068157, 6575.80272591823, 6546.378094081055, 6563.57336773113, 6572.342765723437, 6579.671016449182, 6593.044008618771, 4714.528547145293, 5464.535514481274, 5625.71871406428, 5628.409017053233, 5693.17448969897, 12417.689557761038, 12785.488580456771, 12832.871671283261, 12852.55016074433, 12870.356482175854, 1911.827935485813, 1970.1922211893198, 2010.3064442767222, 2051.2307884543297, 2069.1206237349065, 8683.956580217122, 9783.608655653765, 9981.351212171257, 10010.49947502622, 10154.492275386201, 1698.3206717313174, 1721.7589537464764, 1727.136431784108, 1735.8437740603406, 1735.8698097642728, 90043.0, 95047.52476237643, 96407.0359296412, 96528.0, 97303.51348243213, 11058.834117488244, 11116.944415277872, 11130.888691113147, 11139.888601114048, 11191.99272065518, 13156.0, 13188.340582970814, 13191.274479903697, 13195.736085278433, 13199.40602672882, 8404.991401031915, 8464.915350846413, 8467.0, 8514.233718965323, 8548.914510854936, 8688.044315125331, 8704.695335663222, 8727.0, 8827.646894124291, 8840.778980525409, 3790.56408513019, 4294.119705460374, 4336.392904993303, 4342.1532801103485, 4375.16871794358, 1750.2823842224882, 1777.6800175968192, 1789.0965062643543, 1790.4628611416522, 1790.9283628654969, 900.7162743735834, 938.9436633801994, 947.1712251779693, 1058.8888166742536, 1095.6001059613184, 19439.416817495498, 20359.491012724506, 21262.830544319902, 21323.90803333508, 21606.351809445743, 932.7854593443546, 986.7730422002979, 992.4144754594823, 1014.2342531388754, 1049.7847941172042, 10973.725656858642, 11519.827202591969, 11716.297022178696, 11755.118366122575, 11807.173497855068, 716911.0, 718872.0, 728637.0, 734232.0, 747886.0, 91031.54484227537, 122995.77004230022, 123520.0, 123573.0, 127108.0, 1230.9076819238594, 1231.4889320931893, 1235.4131787400913, 1239.4546399584153, 1260.8297879786294, 15533.533993980198, 17490.82509174892, 19007.714884277022, 19021.90489047546, 19334.516637084187, 50046.749766250934, 50442.49557504525, 50511.989760205324, 50572.24141637952, 51152.0, 69641.80564288546, 70420.0, 70970.22574435681, 71110.28889711037, 74823.62588187025, 10016.549255283384, 10128.949355253177, 10149.137323327599, 10406.791864162524, 10490.632827850988, 11926.344051077274, 13782.793258100935, 20571.588568228253, 20966.895165524074, 21294.893525532272, 11833.881661183277, 14379.784303235669, 16477.505674829776, 16754.827162099024, 16797.832021679627, 12400.0, 12675.619731408073, 15823.841761582236, 16464.176791160153, 16540.917295413445, 16183.271752770917, 16910.746338805173, 17016.0, 17020.14899255057, 17053.0, 9702.272329575451, 9978.800423991624, 10000.899990999997, 10070.69787906364, 10148.492575371054, 10314.948425257826, 12576.434060467118, 15998.360065597246, 16498.25757840924, 17033.91483042577], "unit": "ms", "name": "jquery.html", "value": 9786.050656032596}, {"lowerIsBetter": false, "replicates": [1332.3072002558663, 1566.3264796137655, 1568.1140155811966, 1850.8704390692653, 1868.0753027251512, 7450.552966821988, 7601.239876012396, 7614.543127412352, 8055.234752698499, 8348.749537513884, 8158.0618228903695, 8192.7951801205, 8345.956755405574, 8358.707445239417, 8361.372897032716, 2356.045801450415, 2389.7251816041203, 2389.880505974703, 2390.259019703897, 2391.1869964212165, 2360.3509035015336, 2415.4685969086772, 2421.7578242175728, 2423.9394015149587, 2424.87875606219, 2036.4705176654102, 2198.6152423325852, 2368.111958015744, 2383.3207535852284, 2387.808975281982, 2321.3848330192513, 2358.6344116661858, 2364.7635236476217, 2374.2046414451265, 2374.6675465434855, 2364.373441038126, 2390.725066617344, 2406.3743426709007, 2409.795167410772, 2411.7347091819884, 8281.0, 8352.958235208846, 8358.791030224233, 8362.623681934327, 8392.03491598468, 4620.19146649335, 4783.832565860178, 4811.13399588074, 5069.847904562869, 5228.8692782680355, 3493.6506349365113, 3512.5609298837644, 3533.876314328986, 3539.8407071681836, 3568.518250036238, 1032.4992378696327, 1032.6420756704983, 1043.1446214104437, 1053.7839742852698, 1057.5981127171626, 10911.454427278604, 10986.176036797273, 11016.449177541172, 11025.007749302602, 11028.393438360887, 3918.9020274493364, 4478.193925093515, 4589.678722489461, 4665.46347170073, 4683.063387322549, 9681.66114186, 9703.6118555257, 9713.22294216461, 9715.9028409715, 9727.61089556424, 5192.532672059533, 5207.869803254873, 5210.869728256748, 5226.216067589816, 5229.006488767122, 4737.881552961204, 4746.5490778376, 4750.477447480775, 4762.666613337103, 4771.0, 3705.09225239818, 3740.981295093507, 3748.925021499609, 3781.243751249706, 3794.146317078635, 1219.3232755820604, 1247.1955588645455, 1254.6047994881583, 1255.428779905141, 1255.4350542256022, 1365.931703414845, 1373.7389895919744, 1378.0973462382156, 1399.979000314996, 1400.4608225833128, 7861.567613781182, 7899.486533375312, 7917.247861453268, 7919.802004949807, 7932.405069619802, 504.50306448148547, 507.68269831355406, 519.3248776590493, 522.2401405954328, 522.4827420853404, 5888.0, 5954.285485741739, 6006.069059295816, 6023.45788879003, 6030.728617212236, 8923.196912277926, 9512.2865785065, 9654.71035868925, 9665.371750836313, 9702.320837541305, 9463.763405914908, 9661.903380966241, 9803.460809655537, 9868.111869931741, 9877.357971731815, 7798.922010779933, 7890.7238246659945, 7918.802029949182, 7979.800504987422, 7994.480358776661, 7755.185705500841, 7824.334931530883, 7833.138354781084, 7886.684532618631, 7901.881471777813, 8796.648134074565, 9028.09719028092, 9057.501837399006, 9062.682806101755, 9224.40041397307, 9188.95405522968, 9388.859167112361, 9436.245100391814, 9505.42967421957, 9540.522973851419, 7866.842663146591, 7914.327282181079, 7972.880406793786, 8011.479253848481, 8014.8397032057865, 8019.238172373615, 8075.676972921017, 8090.029196496458, 8092.150324216108, 8100.311473524816, 7419.332260096401, 7478.5138965967035, 7549.547027178387, 7645.694172233048, 7695.0, 7367.226441223809, 7416.7033318666645, 7423.851522969619, 7454.8509029818015, 7544.094708634999, 7510.098788145458, 7574.697012119674, 7583.848323033398, 7585.0139481867, 7595.5442673439775, 6834.1457317835275, 6867.141607299088, 6924.238333783179, 6930.896036559557, 6937.82655433598, 6977.511574189961, 7017.508774385744, 7026.402755765817, 7026.718931242897, 7041.119860017498], "unit": "ms", "name": "mootools.html", "value": 4687.489847486618}, {"lowerIsBetter": false, "replicates": [319.7713634751153, 327.54961927349893, 329.5254833040423, 329.8565124170985, 334.26461784075025, 6719.73121075157, 6765.120534330536, 6827.487938404614, 6847.897281540774, 6893.586384816915, 5614.624417017836, 6787.830304242397, 6790.219124800649, 6794.830129246771, 6798.0, 4884.706917584938, 4901.975490122544, 5037.370328708911, 5041.193409054552, 5046.54581087702, 4984.127777638917, 5009.49905009498, 5013.974930125344, 5034.169362055257, 5041.294218809369, 4932.8407824161295, 4947.554720075193, 4953.529414705597, 4956.653034287601, 4964.280179373988, 4737.976310118462, 4831.734254615994, 4836.588889944359, 4963.0818298614695, 4974.850754477371, 4127.390317776069, 4129.876103716893, 4133.979330103361, 4175.248455278049, 4279.293916503804, 6498.902516462257, 6511.576747511396, 6519.478441724651, 6537.803865884031, 6538.901916471256, 5776.249087618625, 5879.559033072536, 5947.22686050815, 5972.940270597325, 5974.133750606138, 6350.729854029212, 6375.6174629522375, 7046.224915259318, 7144.749933752294, 7191.460640451987, 4779.545943135397, 4797.376341075673, 4807.75961201942, 4836.733979631119, 4841.443234028096, 6263.467605253559, 7643.853421986691, 7721.382289416833, 7725.806854828618, 7750.108737495204, 4759.9524004759505, 4903.0, 4910.484399138039, 4912.410510738734, 4927.581155601814, 4986.002799440126, 4998.600111991032, 5008.373953255843, 5008.57427118699, 5013.39839219296, 4771.570558649738, 5937.821865344046, 5950.107483877453, 5954.4045595440975, 5977.940220597825, 7145.39264162552, 7290.4167666586545, 7345.669444874993, 7360.153582337993, 7383.040204773345, 1715.4339068107495, 1744.2935611077535, 1745.083830988741, 1745.4327343613377, 1745.6159644878107, 1107.1917500224881, 1108.772701596171, 1116.3580940958982, 1125.7241975716001, 1127.971800704989, 6014.578979471483, 6226.750929962841, 6693.732250710014, 6704.329567043256, 6707.3292670732535, 6041.365656606081, 6082.482988945901, 7576.052993375828, 7583.2416758324825, 7593.620318984029, 5392.433794451526, 6528.08606795049, 6647.833804154935, 6670.533062685662, 6671.032700258435, 4001.0597509585223, 4042.0905296308683, 4048.7773172475795, 4048.8785336439955, 4053.6757059435176, 7915.010623672041, 7973.561454120079, 7979.441439099207, 7982.523233201876, 7983.684731427821, 7738.148803631596, 7988.400869934778, 7998.12020677725, 8033.477823941425, 8035.558044307502, 7646.923530764732, 7791.181925897812, 7795.961020194863, 7809.687612495663, 7966.243206895336, 6198.876022479615, 6958.617276049866, 7696.884546731915, 7729.304362607392, 7732.878732583631, 7287.234840341688, 7596.734114305973, 7602.581857997863, 7607.972923655236, 7613.352865006315, 7932.405069619917, 7937.801554961172, 7945.245201705829, 7949.125596184531, 7950.880736788837, 4699.976500117477, 4741.383620129361, 4747.050589881968, 4749.857504274877, 4753.1444340019125, 7345.081864766904, 7547.0, 7564.886526702214, 7586.013818203819, 7594.392448604209, 6115.960286751174, 7257.237990010973, 7297.817554561178, 7358.264173582599, 7394.55632662042, 7350.522216056153, 7357.374623157091, 7362.558246505227, 7365.042544469185, 7379.262073792793, 7014.807482728051, 7183.6351093292105, 7197.71209151628, 7197.964010179916, 7207.063081799332, 7373.631318434164, 7377.96311018463, 7390.0, 7397.223291554309, 7397.334239918433, 6990.300969902969, 7177.7487787927175, 7202.3877970373105, 7215.350618444365, 7226.927730722626], "unit": "ms", "name": "prototype.html", "value": 5303.41436587024}, {"lowerIsBetter": false, "replicates": [710.5345998371066, 730.7150211417545, 736.269468663835, 749.7001199520191, 837.3092198935872, 14600.196989165592, 14980.700385992288, 14981.700365992674, 15006.0, 15011.549653510412, 11209.66371008869, 13508.0, 13570.796438053412, 13587.184768913847, 13598.660033499167, 630.4546567219368, 754.2532892436503, 926.800737841364, 947.9951251673214, 951.7668171298008, 737.8930055142001, 943.3679434778714, 959.0649117110831, 961.3703024518951, 963.8072385522923, 967.042627798478, 1004.3070281505737, 1006.1397505133116, 1007.9193664506822, 1007.9344842585245, 789.2344425906862, 798.2177466083212, 798.4291231769255, 982.592224226945, 999.2256001598746, 584.9444302791228, 588.1853632718672, 595.1370512756521, 725.4849057169416, 743.0711610486892, 14256.714865702732, 14436.0, 14447.133172009713, 14448.49430269946, 14477.42090316386, 11923.403829808474, 12151.210171338924, 12381.752364952741, 12388.442520086617, 12448.502059917593, 10000.39997600139, 10042.4476653784, 10050.045245701647, 10123.443210623413, 10689.412082335468, 3435.12404336895, 3537.239493508908, 3539.1152211947015, 3543.6102028776813, 3549.503069570262, 77770.6111469439, 78369.04077398054, 79684.0, 79776.60111699405, 79865.99999999942, 9262.72211833646, 9422.858657120149, 9453.149216570404, 9646.662366817127, 9968.401895886125, 20156.581210254863, 20270.493237669176, 20275.88482633469, 20306.796932030786, 20340.796592034185, 7097.361237488651, 7261.745838895613, 7337.3029562191505, 7383.8154046149275, 7502.924970750222, 3930.9213815723524, 4169.041120542292, 4169.687273454503, 4192.245395828719, 4208.768517731554, 3550.7692000019915, 3591.5151454553825, 3594.1913069559664, 3605.8197090145914, 3609.801460919675, 684.8869936460528, 692.6398272898065, 695.1866316409712, 706.9081019467436, 708.674009955416, 478.35899894142017, 479.4653960833645, 486.16137163392864, 505.6056276104644, 510.79312878284355, 8447.746567602982, 8556.486610803371, 8713.25937295337, 8780.473171609723, 8899.54968657592, 518.8547206782107, 526.147640821871, 526.8383215010891, 536.5439376529919, 552.8175702018324, 3904.39481880309, 4004.3392840181627, 4085.22380747657, 4130.235906357333, 4210.400466272453, 95305.04694952961, 95676.0, 101099.49450252701, 101235.97528049545, 101555.98444015613, 86124.0, 86407.70388444178, 86468.0, 88705.55647221852, 89366.0, 76908.2309176901, 76913.0, 77020.61489692515, 78136.82794758084, 78271.0, 8223.835523289381, 8408.621612027597, 8474.364422668448, 8851.0, 9034.412763170372, 50236.49763502464, 53145.0, 53531.73234133804, 54581.0, 54625.63435914134, 67517.0, 67529.32470675427, 71727.92408113778, 77649.2235077642, 78320.0, 10688.305260158066, 10886.103716111867, 10983.231173817756, 11412.516372871474, 11424.428778561205, 10538.8419173714, 12111.939440302742, 12165.635030949086, 12356.443960021641, 12958.611241662766, 9693.0, 11147.331160130418, 11472.369019703996, 11553.480093395985, 12169.148159629096, 11332.263402878787, 11415.686841829662, 11487.310761354345, 11548.42257887119, 12331.938340308241, 11204.551817927191, 11284.943575282072, 11421.200515963803, 11516.314779270553, 11776.764464710486, 9817.263705221994, 9830.901690982999, 9843.286742905377, 10164.390136591828, 10419.166466682798, 8358.164258441073, 9264.583093760932, 9403.105484895881, 9450.669226577036, 10139.239557033105], "unit": "ms", "name": "yui.html", "value": 6925.9147051332675}], "name": "dromaeo_css", "value": 7674.001658798236}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 110.0, 110.0, 110.0, 110.0, 102.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 108.6}, {"lowerIsBetter": true, "replicates": [164.0, 145.0, 141.0, 153.0, 115.0, 141.0, 138.0, 111.0, 153.0, 117.0], "unit": "ms", "name": "audio-beat-detection", "value": 137.8}, {"lowerIsBetter": true, "replicates": [182.0, 181.0, 183.0, 183.0, 184.0, 184.0, 185.0, 185.0, 184.0, 180.0], "unit": "ms", "name": "audio-dft", "value": 183.1}, {"lowerIsBetter": true, "replicates": [59.0, 70.0, 72.0, 70.0, 56.0, 56.0, 56.0, 68.0, 72.0, 55.0], "unit": "ms", "name": "audio-fft", "value": 63.4}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 114.0, 73.0, 74.0, 74.0, 111.0, 74.0, 75.0, 113.0], "unit": "ms", "name": "audio-oscillator", "value": 87.5}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 85.0, 86.0, 86.0, 88.0, 86.0, 86.0, 86.0, 86.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 86.1}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 94.0, 95.0, 98.0, 95.0, 95.0, 93.0, 94.0, 94.0], "unit": "ms", "name": "imaging-darkroom", "value": 94.7}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 86.0, 85.0, 87.0, 85.0, 87.0, 87.0, 86.0, 86.0], "unit": "ms", "name": "imaging-desaturate", "value": 86.1}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 56.0, 54.0, 55.0, 55.0, 54.0, 65.0, 52.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 66.0, 65.0, 67.0, 76.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.0}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 81.0, 80.0, 81.0, 82.0, 82.0, 83.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [123.0, 119.0, 119.0, 118.0, 118.0, 118.0, 121.0, 117.0, 125.0, 135.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [137.0, 125.0, 135.0, 135.0, 136.0, 119.0, 135.0, 134.0, 137.0, 125.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 131.8}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 65.0, 66.0, 64.0, 64.0, 66.0, 90.0, 62.0, 53.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1369.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [147.90711433219937], "unit": "score", "name": "Richards", "value": 238.67682200000002}, {"lowerIsBetter": false, "replicates": [160.74586079408456], "unit": "score", "name": "DeltaBlue", "value": 411.3200779999999}, {"lowerIsBetter": false, "replicates": [282.08744710860367], "unit": "score", "name": "Encrypt", "value": 943.6116450000002}, {"lowerIsBetter": false, "replicates": [4758.293838862559], "unit": "score", "name": "Decrypt", "value": 55.94042928286857}, {"lowerIsBetter": false, "replicates": [1697.792869269949], "unit": "score", "name": "RayTrace", "value": 435.85352100000017}, {"lowerIsBetter": false, "replicates": [798.7220447284345], "unit": "score", "name": "Earley", "value": 834.4116759999996}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [27540.54054054054], "unit": "score", "name": "RegExp", "value": 33.07796368989208}, {"lowerIsBetter": false, "replicates": [610.1281269066504], "unit": "score", "name": "Splay", "value": 133.56374900000003}, {"lowerIsBetter": false, "replicates": [4522.522522522522], "unit": "score", "name": "NavierStokes", "value": 328.13545816733085}], "name": "v8_7", "value": 20819.449355340086}]} 22:48:48 INFO - RETURN: dromaeo_css: 7674.00 22:48:48 INFO - RETURN: kraken: 1369.70 22:48:48 INFO - RETURN: v8_7: 20819.45 22:48:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,59]]", "result": "20819.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1369.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7674.00"}}} 22:48:48 INFO - Return code: 0 22:48:48 INFO - # TBPL SUCCESS # 22:48:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:48:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:48:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:48:48 INFO - 2015-11-19 22:48:48.706 screenresolution[1951:12902] starting screenresolution argv=screenresolution get 22:48:48 INFO - 2015-11-19 22:48:48.709 screenresolution[1951:12902] Display 0: 1600x1200x32@60 22:48:48 INFO - 2015-11-19 22:48:48.715 screenresolution[1952:12905] starting screenresolution argv=screenresolution list 22:48:48 INFO - Available Modes on Display 0 22:48:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:48:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:48:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:48:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:48:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:48:48 INFO - Intel Iris: 22:48:48 INFO - Chipset Model: Intel Iris 22:48:48 INFO - Type: GPU 22:48:48 INFO - Bus: Built-In 22:48:48 INFO - VRAM (Dynamic, Max): 1536 MB 22:48:48 INFO - Vendor: Intel (0x8086) 22:48:48 INFO - Device ID: 0x0a2e 22:48:48 INFO - Revision ID: 0x0009 22:48:48 INFO - Displays: 22:48:48 INFO - Display: 22:48:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:48:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:48:48 INFO - Display Serial Number: 1600x1200 60 22:48:48 INFO - Main Display: Yes 22:48:48 INFO - Mirror: Off 22:48:48 INFO - Online: Yes 22:48:48 INFO - Rotation: Supported 22:48:48 INFO - Return code: 0 22:48:48 INFO - Running post-action listener: _resource_record_post_action 22:48:48 INFO - Running post-run listener: _resource_record_post_run 22:48:50 INFO - Total resource usage - Wall time: 1238s; CPU: 52.0%; Read bytes: 3010560; Write bytes: 687960576; Read time: 44; Write time: 2092 22:48:50 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 338383360; Write bytes: 336156672; Read time: 26148; Write time: 656 22:48:50 INFO - run-tests - Wall time: 1208s; CPU: 52.0%; Read bytes: 3010560; Write bytes: 340593152; Read time: 44; Write time: 1404 22:48:50 INFO - Running post-run listener: _upload_blobber_files 22:48:50 INFO - Blob upload gear active. 22:48:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:48:50 INFO - Copying logs to upload dir... 22:48:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.683732 ========= master_lag: 1.81 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2015-11-19 22:48:51.861138) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:48:51.864783) ========= 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.xLagon7vLn/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.GkaKbPi6Ey/Listeners TMPDIR=/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009537 build_url: 'https://queue.taskcluster.net/v1/task/elKApx6KTOGP4UeVaVpX6Q/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 22:48:51.888688) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:48:51.889013) ========= 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.xLagon7vLn/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.GkaKbPi6Ey/Listeners TMPDIR=/var/folders/yh/_cndqm_d5x1cx17ndrz3rb4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005309 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 22:48:51.937271) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:48:51.937602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-19 22:48:51.937979) ========= ========= Total master_lag: 2.19 =========