builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0273 starttime: 1471880677.95 results: success (0) buildid: 20160822051814 builduid: 8bbb730db49f4ddf9a36b1237b0ab0c1 revision: 662270014cb72f82af415385f2f0bef5b135ec04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:37.954527) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:37.955496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:37.956108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:37.982027) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:37.982709) ========= 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.4UHtTAD7qt/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.m17MRYyF64/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 --2016-08-22 08:44:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2016-08-22 08:44:38 (18.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082188 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:38.092779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:38.093564) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4UHtTAD7qt/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.m17MRYyF64/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.025108 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:38.146213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 08:44:38.147032) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 662270014cb72f82af415385f2f0bef5b135ec04 --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 662270014cb72f82af415385f2f0bef5b135ec04 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4UHtTAD7qt/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.m17MRYyF64/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 2016-08-22 08:44:38,232 truncating revision to first 12 chars 2016-08-22 08:44:38,232 Setting DEBUG logging. 2016-08-22 08:44:38,232 attempt 1/10 2016-08-22 08:44:38,232 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/662270014cb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 08:44:39,301 unpacking tar archive at: fx-team-662270014cb7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.318081 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 08:44:39.492452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:39.493267) ========= script_repo_revision: 662270014cb72f82af415385f2f0bef5b135ec04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:39.494234) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:39.494911) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 08:44:39.514472) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-22 08:44:39.514810) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--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.4UHtTAD7qt/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.m17MRYyF64/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 08:44:39 INFO - MultiFileLogger online at 20160822 08:44:39 in /builds/slave/test 08:44:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:44:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:39 INFO - {'append_to_log': False, 08:44:39 INFO - 'base_work_dir': '/builds/slave/test', 08:44:39 INFO - 'blob_upload_branch': 'Fx-Team', 08:44:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:39 INFO - 'branch': 'Fx-Team', 08:44:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:39 INFO - 'config_files': ('talos/mac_config.py',), 08:44:39 INFO - 'default_actions': ('clobber', 08:44:39 INFO - 'read-buildbot-config', 08:44:39 INFO - 'download-and-extract', 08:44:39 INFO - 'populate-webroot', 08:44:39 INFO - 'create-virtualenv', 08:44:39 INFO - 'install', 08:44:39 INFO - 'run-tests'), 08:44:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:39 INFO - 'download_minidump_stackwalk': True, 08:44:39 INFO - 'download_symbols': 'ondemand', 08:44:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:39 INFO - 'installer_path': 'installer.exe', 08:44:39 INFO - 'log_level': 'info', 08:44:39 INFO - 'log_name': 'talos', 08:44:39 INFO - 'log_to_console': True, 08:44:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:44:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:44:39 INFO - 'opt_config_files': (), 08:44:39 INFO - 'pip_index': False, 08:44:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:44:39 INFO - 'cmd': ('bash', 08:44:39 INFO - '-c', 08:44:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:44:39 INFO - 'enabled': True, 08:44:39 INFO - 'halt_on_failure': False, 08:44:39 INFO - 'name': 'check_screen_resolution'},), 08:44:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:44:39 INFO - 'cmd': ('bash', 08:44:39 INFO - '-c', 08:44:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:44:39 INFO - 'enabled': True, 08:44:39 INFO - 'halt_on_failure': False, 08:44:39 INFO - 'name': 'check_screen_resolution'},), 08:44:39 INFO - 'run_cmd_checks_enabled': True, 08:44:39 INFO - 'sps_profile': False, 08:44:39 INFO - 'sps_profile_interval': 0, 08:44:39 INFO - 'suite': 'dromaeojs-e10s', 08:44:39 INFO - 'system_bits': '32', 08:44:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:39 INFO - 'title': 't-yosemite-r7-0273', 08:44:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:39 INFO - 'use_talos_json': True, 08:44:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:39 INFO - 'work_dir': 'build'} 08:44:39 INFO - [mozharness: 2016-08-22 15:44:39.713196Z] Running clobber step. 08:44:39 INFO - Running pre-action listener: _resource_record_pre_action 08:44:39 INFO - Running main action method: clobber 08:44:39 INFO - rmtree: /builds/slave/test/build 08:44:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:41 INFO - Running post-action listener: _resource_record_post_action 08:44:41 INFO - [mozharness: 2016-08-22 15:44:41.681690Z] Finished clobber step (success) 08:44:41 INFO - [mozharness: 2016-08-22 15:44:41.681854Z] Running read-buildbot-config step. 08:44:41 INFO - Running pre-action listener: _resource_record_pre_action 08:44:41 INFO - Running main action method: read_buildbot_config 08:44:41 INFO - Using buildbot properties: 08:44:41 INFO - { 08:44:41 INFO - "project": "", 08:44:41 INFO - "product": "firefox", 08:44:41 INFO - "script_repo_revision": "production", 08:44:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:44:41 INFO - "repository": "", 08:44:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:44:41 INFO - "buildid": "20160822051814", 08:44:41 INFO - "pgo_build": "False", 08:44:41 INFO - "basedir": "/builds/slave/test", 08:44:41 INFO - "buildnumber": 29, 08:44:41 INFO - "slavename": "t-yosemite-r7-0273", 08:44:41 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:44:41 INFO - "platform": "yosemite_r7", 08:44:41 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 08:44:41 INFO - "branch": "fx-team", 08:44:41 INFO - "repo_path": "integration/fx-team", 08:44:41 INFO - "revision": "662270014cb72f82af415385f2f0bef5b135ec04", 08:44:41 INFO - "stage_platform": "macosx64", 08:44:41 INFO - "builduid": "8bbb730db49f4ddf9a36b1237b0ab0c1", 08:44:41 INFO - "slavebuilddir": "test" 08:44:41 INFO - } 08:44:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 08:44:41 INFO - Running post-action listener: _resource_record_post_action 08:44:41 INFO - [mozharness: 2016-08-22 15:44:41.685208Z] Finished read-buildbot-config step (success) 08:44:41 INFO - [mozharness: 2016-08-22 15:44:41.685340Z] Running download-and-extract step. 08:44:41 INFO - Running pre-action listener: _resource_record_pre_action 08:44:41 INFO - Running main action method: download_and_extract 08:44:41 INFO - mkdir: /builds/slave/test/build/tests 08:44: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:41 INFO - trying https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 08:44:41 INFO - Downloading https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 08:44:42 INFO - Downloaded 1199 bytes. 08:44:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 08:44:42 INFO - Using the following test package requirements: 08:44:42 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:44:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:44:42 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 08:44:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:44:42 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 08:44:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:44:42 INFO - u'jsshell-mac.zip'], 08:44:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:44:42 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 08:44:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 08:44:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:44:42 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 08:44:42 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:44:42 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 08:44:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:44:42 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 08:44:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 08:44:42 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 08:44:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:44:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:42 INFO - trying https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:44:42 INFO - Downloading https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:44:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:44:43 INFO - Downloaded 16351892 bytes. 08:44:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:44:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:44:50 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:50 INFO - trying https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:44:50 INFO - Downloading https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 08:44:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:44:51 INFO - Downloaded 16351892 bytes. 08:44:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 08:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:57 INFO - trying https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:44:57 INFO - Downloading https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 08:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:44:59 INFO - Downloaded 14413981 bytes. 08:44:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 08:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:59 INFO - trying https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:44:59 INFO - Downloading https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 08:44:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 08:45:02 INFO - Downloaded 111476631 bytes. 08:45:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:45:02 INFO - mkdir: /builds/slave/test/properties 08:45:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:02 INFO - Contents: 08:45:02 INFO - build_url:https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 08:45:03 INFO - Running post-action listener: _resource_record_post_action 08:45:03 INFO - Running post-action listener: set_extra_try_arguments 08:45:03 INFO - [mozharness: 2016-08-22 15:45:03.027431Z] Finished download-and-extract step (success) 08:45:03 INFO - [mozharness: 2016-08-22 15:45:03.027536Z] Running populate-webroot step. 08:45:03 INFO - Running pre-action listener: _resource_record_pre_action 08:45:03 INFO - Running main action method: populate_webroot 08:45:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:03 INFO - '--tppagecycles', 08:45:03 INFO - '7'], 08:45:03 INFO - 'tests': ['tsvgm']}}, 08:45:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:03 INFO - 'talos_options': ['--disable-e10s'], 08:45:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:03 INFO - 'talos_options': ['--disable-e10s'], 08:45:03 INFO - 'tests': ['damp', 'tps']}, 08:45:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:03 INFO - 'tests': ['damp', 'tps']}, 08:45:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:03 INFO - 'tests': ['dromaeo_dom']}, 08:45:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:45:03 INFO - 'tests': ['basic_compositor_video']}, 08:45:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:45:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:03 INFO - 'tests': ['a11yr', 08:45:03 INFO - 'ts_paint', 08:45:03 INFO - 'tpaint', 08:45:03 INFO - 'sessionrestore', 08:45:03 INFO - 'sessionrestore_no_auto_restore', 08:45:03 INFO - 'tabpaint']}, 08:45:03 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:03 INFO - 'ts_paint', 08:45:03 INFO - 'tpaint', 08:45:03 INFO - 'sessionrestore', 08:45:03 INFO - 'sessionrestore_no_auto_restore', 08:45:03 INFO - 'tabpaint']}, 08:45:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:03 INFO - 'ts_paint', 08:45:03 INFO - 'tpaint', 08:45:03 INFO - 'sessionrestore', 08:45:03 INFO - 'sessionrestore_no_auto_restore', 08:45:03 INFO - 'tabpaint']}, 08:45:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:03 INFO - 'ts_paint', 08:45:03 INFO - 'tpaint', 08:45:03 INFO - 'sessionrestore', 08:45:03 INFO - 'sessionrestore_no_auto_restore', 08:45:03 INFO - 'tabpaint']}, 08:45:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:03 INFO - 'tests': ['a11yr', 08:45:03 INFO - 'ts_paint', 08:45:03 INFO - 'tpaint', 08:45:03 INFO - 'sessionrestore', 08:45:03 INFO - 'sessionrestore_no_auto_restore', 08:45:03 INFO - 'tabpaint']}, 08:45:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:03 INFO - 'tests': ['a11yr', 08:45:03 INFO - 'ts_paint', 08:45:03 INFO - 'tpaint', 08:45:03 INFO - 'sessionrestore', 08:45:03 INFO - 'sessionrestore_no_auto_restore', 08:45:03 INFO - 'tabpaint']}, 08:45:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:03 INFO - 'tests': ['tsvgx', 08:45:03 INFO - 'tsvgr_opacity', 08:45:03 INFO - 'tart', 08:45:03 INFO - 'tscrollx', 08:45:03 INFO - 'cart']}, 08:45:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:03 INFO - 'tsvgr_opacity', 08:45:03 INFO - 'tart', 08:45:03 INFO - 'tscrollx', 08:45:03 INFO - 'cart']}, 08:45:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:03 INFO - 'talos_options': ['--disable-e10s'], 08:45:03 INFO - 'tests': ['tp5o']}, 08:45:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:03 INFO - 'tests': ['tp5o']}, 08:45:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:03 INFO - 'talos_options': ['--disable-e10s', 08:45:03 INFO - '--xperf_path', 08:45:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:03 INFO - 'tests': ['tp5n']}, 08:45:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:03 INFO - 'talos_options': ['--xperf_path', 08:45:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:03 INFO - 'tests': ['tp5n']}}, 08:45:03 INFO - 'talos.zip': {'path': '', 08:45:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:03 INFO - Running post-action listener: _resource_record_post_action 08:45:03 INFO - [mozharness: 2016-08-22 15:45:03.046500Z] Finished populate-webroot step (success) 08:45:03 INFO - [mozharness: 2016-08-22 15:45:03.046631Z] Running create-virtualenv step. 08:45:03 INFO - Running pre-action listener: _resource_record_pre_action 08:45:03 INFO - Running main action method: create_virtualenv 08:45:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:45:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:03 INFO - Using real prefix '/tools/python27' 08:45:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:06 INFO - Installing pip.................done. 08:45:06 INFO - Return code: 0 08:45:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:06 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1088a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108939618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32ad635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108808d30>, '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 0x10856ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108800b20>, '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.4UHtTAD7qt/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.m17MRYyF64/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 08:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:45:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UHtTAD7qt/Render', 08:45:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:06 INFO - 'HOME': '/Users/cltbld', 08:45:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:06 INFO - 'LOGNAME': 'cltbld', 08:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:06 INFO - 'MOZ_NO_REMOTE': '1', 08:45:06 INFO - 'NO_EM_RESTART': '1', 08:45:06 INFO - 'PAGER': '/bin/cat', 08:45:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:06 INFO - 'PWD': '/builds/slave/test', 08:45:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:06 INFO - 'SHELL': '/bin/bash', 08:45:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m17MRYyF64/Listeners', 08:45:06 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 08:45:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:06 INFO - 'USER': 'cltbld', 08:45:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:06 INFO - 'XPC_FLAGS': '0x0', 08:45:06 INFO - 'XPC_SERVICE_NAME': '0', 08:45:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:45:07 INFO - Cleaning up... 08:45:07 INFO - Return code: 0 08:45:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108939618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32ad635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108808d30>, '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 0x10856ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108800b20>, '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.4UHtTAD7qt/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.m17MRYyF64/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 08:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 08:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 08:45:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UHtTAD7qt/Render', 08:45:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:07 INFO - 'HOME': '/Users/cltbld', 08:45:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:07 INFO - 'LOGNAME': 'cltbld', 08:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:07 INFO - 'MOZ_NO_REMOTE': '1', 08:45:07 INFO - 'NO_EM_RESTART': '1', 08:45:07 INFO - 'PAGER': '/bin/cat', 08:45:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:07 INFO - 'PWD': '/builds/slave/test', 08:45:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:07 INFO - 'SHELL': '/bin/bash', 08:45:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m17MRYyF64/Listeners', 08:45:07 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 08:45:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:07 INFO - 'USER': 'cltbld', 08:45:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:07 INFO - 'XPC_FLAGS': '0x0', 08:45:07 INFO - 'XPC_SERVICE_NAME': '0', 08:45:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:07 INFO - Downloading/unpacking psutil>=3.1.1 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:10 INFO - Installing collected packages: psutil 08:45:10 INFO - Running setup.py install for psutil 08:45:10 INFO - building 'psutil._psutil_osx' extension 08:45:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:45:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:45:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:45:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:45:11 INFO - building 'psutil._psutil_posix' extension 08:45:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:45:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:45:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:45:11 INFO - ^ 08:45:11 INFO - 1 warning generated. 08:45:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:45:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:11 INFO - Successfully installed psutil 08:45:11 INFO - Cleaning up... 08:45:11 INFO - Return code: 0 08:45:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108939618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32ad635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108808d30>, '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 0x10856ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108800b20>, '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.4UHtTAD7qt/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.m17MRYyF64/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 08:45:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 08:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 08:45:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UHtTAD7qt/Render', 08:45:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:11 INFO - 'HOME': '/Users/cltbld', 08:45:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:11 INFO - 'LOGNAME': 'cltbld', 08:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:11 INFO - 'MOZ_NO_REMOTE': '1', 08:45:11 INFO - 'NO_EM_RESTART': '1', 08:45:11 INFO - 'PAGER': '/bin/cat', 08:45:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:11 INFO - 'PWD': '/builds/slave/test', 08:45:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:11 INFO - 'SHELL': '/bin/bash', 08:45:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m17MRYyF64/Listeners', 08:45:11 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 08:45:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:11 INFO - 'USER': 'cltbld', 08:45:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:11 INFO - 'XPC_FLAGS': '0x0', 08:45:11 INFO - 'XPC_SERVICE_NAME': '0', 08:45:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:45:14 INFO - Installing collected packages: mozsystemmonitor 08:45:14 INFO - Running setup.py install for mozsystemmonitor 08:45:14 INFO - Successfully installed mozsystemmonitor 08:45:14 INFO - Cleaning up... 08:45:14 INFO - Return code: 0 08:45:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108939618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32ad635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108808d30>, '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 0x10856ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108800b20>, '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.4UHtTAD7qt/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.m17MRYyF64/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 08:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema==2.5.1 08:45:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UHtTAD7qt/Render', 08:45:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:14 INFO - 'HOME': '/Users/cltbld', 08:45:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:14 INFO - 'LOGNAME': 'cltbld', 08:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:14 INFO - 'MOZ_NO_REMOTE': '1', 08:45:14 INFO - 'NO_EM_RESTART': '1', 08:45:14 INFO - 'PAGER': '/bin/cat', 08:45:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:14 INFO - 'PWD': '/builds/slave/test', 08:45:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:14 INFO - 'SHELL': '/bin/bash', 08:45:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m17MRYyF64/Listeners', 08:45:14 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 08:45:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:14 INFO - 'USER': 'cltbld', 08:45:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:14 INFO - 'XPC_FLAGS': '0x0', 08:45:14 INFO - 'XPC_SERVICE_NAME': '0', 08:45:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:15 INFO - Downloading/unpacking jsonschema==2.5.1 08:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:17 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:18 INFO - warning: no files found matching '*.txt' 08:45:18 INFO - no previously-included directories found matching 'build' 08:45:18 INFO - no previously-included directories found matching 'dist' 08:45:18 INFO - no previously-included directories found matching '.git*' 08:45:18 INFO - Installing collected packages: jsonschema, functools32 08:45:18 INFO - Running setup.py install for functools32 08:45:18 INFO - warning: no files found matching '*.txt' 08:45:18 INFO - no previously-included directories found matching 'build' 08:45:18 INFO - no previously-included directories found matching 'dist' 08:45:18 INFO - no previously-included directories found matching '.git*' 08:45:18 INFO - Successfully installed jsonschema functools32 08:45:18 INFO - Cleaning up... 08:45:18 INFO - Return code: 0 08:45:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108939618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32ad635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108808d30>, '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 0x10856ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108800b20>, '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.4UHtTAD7qt/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.m17MRYyF64/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 08:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 functools32==3.2.3-2 08:45:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UHtTAD7qt/Render', 08:45:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:18 INFO - 'HOME': '/Users/cltbld', 08:45:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:18 INFO - 'LOGNAME': 'cltbld', 08:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:18 INFO - 'MOZ_NO_REMOTE': '1', 08:45:18 INFO - 'NO_EM_RESTART': '1', 08:45:18 INFO - 'PAGER': '/bin/cat', 08:45:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:18 INFO - 'PWD': '/builds/slave/test', 08:45:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:18 INFO - 'SHELL': '/bin/bash', 08:45:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m17MRYyF64/Listeners', 08:45:18 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 08:45:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:18 INFO - 'USER': 'cltbld', 08:45:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:18 INFO - 'XPC_FLAGS': '0x0', 08:45:18 INFO - 'XPC_SERVICE_NAME': '0', 08:45:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:45:18 INFO - Cleaning up... 08:45:18 INFO - Return code: 0 08:45:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1088a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108939618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32ad635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108808d30>, '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 0x10856ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108800b20>, '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.4UHtTAD7qt/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.m17MRYyF64/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 08:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:45:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UHtTAD7qt/Render', 08:45:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:18 INFO - 'HOME': '/Users/cltbld', 08:45:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:18 INFO - 'LOGNAME': 'cltbld', 08:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:18 INFO - 'MOZ_NO_REMOTE': '1', 08:45:18 INFO - 'NO_EM_RESTART': '1', 08:45:18 INFO - 'PAGER': '/bin/cat', 08:45:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:18 INFO - 'PWD': '/builds/slave/test', 08:45:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:18 INFO - 'SHELL': '/bin/bash', 08:45:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m17MRYyF64/Listeners', 08:45:18 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 08:45:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:18 INFO - 'USER': 'cltbld', 08:45:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:18 INFO - 'XPC_FLAGS': '0x0', 08:45:18 INFO - 'XPC_SERVICE_NAME': '0', 08:45:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:18 INFO - Downloading/unpacking blobuploader==1.2.4 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:21 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:22 INFO - Downloading docopt-0.6.1.tar.gz 08:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:22 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:22 INFO - Running setup.py install for blobuploader 08:45:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:22 INFO - Running setup.py install for requests 08:45:23 INFO - Running setup.py install for docopt 08:45:23 INFO - Successfully installed blobuploader requests docopt 08:45:23 INFO - Cleaning up... 08:45:23 INFO - Return code: 0 08:45:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x1088a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108939618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32ad635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108808d30>, '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 0x10856ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108800b20>, '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.4UHtTAD7qt/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.m17MRYyF64/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 08:45:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UHtTAD7qt/Render', 08:45:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:23 INFO - 'HOME': '/Users/cltbld', 08:45:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:23 INFO - 'LOGNAME': 'cltbld', 08:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:23 INFO - 'MOZ_NO_REMOTE': '1', 08:45:23 INFO - 'NO_EM_RESTART': '1', 08:45:23 INFO - 'PAGER': '/bin/cat', 08:45:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:23 INFO - 'PWD': '/builds/slave/test', 08:45:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:23 INFO - 'SHELL': '/bin/bash', 08:45:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m17MRYyF64/Listeners', 08:45:23 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 08:45:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:23 INFO - 'USER': 'cltbld', 08:45:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:23 INFO - 'XPC_FLAGS': '0x0', 08:45:23 INFO - 'XPC_SERVICE_NAME': '0', 08:45:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:23 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-xIYEzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:23 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-NA67bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:23 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-WC4rj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-8M3rkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-3tYorJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-8BEm5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-wGBHBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-k1no0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-iQcfp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-gn45_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-1dvuog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:24 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-uj36ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-4SI4bZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-aCVr26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-PMEIhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Xkdmzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:25 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-k3TaBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:25 INFO - Running setup.py install for manifestparser 08:45:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:25 INFO - Running setup.py install for mozcrash 08:45:25 INFO - Running setup.py install for mozdebug 08:45:25 INFO - Running setup.py install for mozdevice 08:45:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:45:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:26 INFO - Running setup.py install for mozfile 08:45:26 INFO - Running setup.py install for mozhttpd 08:45:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:26 INFO - Running setup.py install for mozinfo 08:45:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:26 INFO - Running setup.py install for mozInstall 08:45:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:26 INFO - Running setup.py install for mozleak 08:45:26 INFO - Running setup.py install for mozlog 08:45:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for moznetwork 08:45:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for mozprocess 08:45:27 INFO - Running setup.py install for mozprofile 08:45:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for mozrunner 08:45:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for mozscreenshot 08:45:27 INFO - Running setup.py install for moztest 08:45:27 INFO - Running setup.py install for mozversion 08:45:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:28 INFO - Cleaning up... 08:45:28 INFO - Return code: 0 08:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1088a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108939618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32ad635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108808d30>, '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 0x10856ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108800b20>, '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.4UHtTAD7qt/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.m17MRYyF64/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 08:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UHtTAD7qt/Render', 08:45:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:28 INFO - 'HOME': '/Users/cltbld', 08:45:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:28 INFO - 'LOGNAME': 'cltbld', 08:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:28 INFO - 'MOZ_NO_REMOTE': '1', 08:45:28 INFO - 'NO_EM_RESTART': '1', 08:45:28 INFO - 'PAGER': '/bin/cat', 08:45:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:28 INFO - 'PWD': '/builds/slave/test', 08:45:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:28 INFO - 'SHELL': '/bin/bash', 08:45:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m17MRYyF64/Listeners', 08:45:28 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 08:45:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:28 INFO - 'USER': 'cltbld', 08:45:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:28 INFO - 'XPC_FLAGS': '0x0', 08:45:28 INFO - 'XPC_SERVICE_NAME': '0', 08:45:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-3Ob_sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-rarPtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-smJ_fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-bts7QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-VtXk3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:28 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-BfVfL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-YzYQ9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-kUJ8zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-DcH8g9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-oWAmvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-DaZeW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-78VE9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-0fSKNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-mzBLBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-fll90m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:29 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-SuNeRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:30 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-2ygxBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:45:30 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:30 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:45:30 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:30 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:32 INFO - Downloading blessings-1.6.tar.gz 08:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:32 INFO - Installing collected packages: blessings 08:45:32 INFO - Running setup.py install for blessings 08:45:32 INFO - Successfully installed blessings 08:45:32 INFO - Cleaning up... 08:45:32 INFO - Return code: 0 08:45:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:33 INFO - Reading from file tmpfile_stdout 08:45:33 INFO - Current package versions: 08:45:33 INFO - blessings == 1.6 08:45:33 INFO - blobuploader == 1.2.4 08:45:33 INFO - docopt == 0.6.1 08:45:33 INFO - functools32 == 3.2.3-2 08:45:33 INFO - jsonschema == 2.5.1 08:45:33 INFO - manifestparser == 1.1 08:45:33 INFO - mozInstall == 1.12 08:45:33 INFO - mozcrash == 0.17 08:45:33 INFO - mozdebug == 0.1 08:45:33 INFO - mozdevice == 0.48 08:45:33 INFO - mozfile == 1.2 08:45:33 INFO - mozhttpd == 0.7 08:45:33 INFO - mozinfo == 0.9 08:45:33 INFO - mozleak == 0.1 08:45:33 INFO - mozlog == 3.3 08:45:33 INFO - moznetwork == 0.27 08:45:33 INFO - mozprocess == 0.23 08:45:33 INFO - mozprofile == 0.28 08:45:33 INFO - mozrunner == 6.12 08:45:33 INFO - mozscreenshot == 0.1 08:45:33 INFO - mozsystemmonitor == 0.3 08:45:33 INFO - moztest == 0.7 08:45:33 INFO - mozversion == 1.4 08:45:33 INFO - psutil == 3.1.1 08:45:33 INFO - requests == 1.2.3 08:45:33 INFO - wsgiref == 0.1.2 08:45:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x1088a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108939618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32ad635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108808d30>, '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 0x10856ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108800b20>, '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.4UHtTAD7qt/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.m17MRYyF64/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 08:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UHtTAD7qt/Render', 08:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:33 INFO - 'HOME': '/Users/cltbld', 08:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:33 INFO - 'LOGNAME': 'cltbld', 08:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:33 INFO - 'MOZ_NO_REMOTE': '1', 08:45:33 INFO - 'NO_EM_RESTART': '1', 08:45:33 INFO - 'PAGER': '/bin/cat', 08:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:33 INFO - 'PWD': '/builds/slave/test', 08:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:33 INFO - 'SHELL': '/bin/bash', 08:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m17MRYyF64/Listeners', 08:45:33 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 08:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:33 INFO - 'USER': 'cltbld', 08:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:33 INFO - 'XPC_FLAGS': '0x0', 08:45:33 INFO - 'XPC_SERVICE_NAME': '0', 08:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:45:33 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 2)) 08:45:33 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 3)) 08:45:33 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 4)) 08:45:33 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 5)) 08:45:33 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 6)) 08:45:33 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 7)) 08:45:33 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 8)) 08:45:33 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 9)) 08:45:33 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:45:33 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 4)) 08:45:33 INFO - Cleaning up... 08:45:33 INFO - Return code: 0 08:45:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:33 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1088a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108939618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa32ad635a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108808d30>, '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 0x10856ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108800b20>, '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.4UHtTAD7qt/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.m17MRYyF64/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 08:45:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 08:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 08:45:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UHtTAD7qt/Render', 08:45:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:33 INFO - 'HOME': '/Users/cltbld', 08:45:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:33 INFO - 'LOGNAME': 'cltbld', 08:45:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:33 INFO - 'MOZ_NO_REMOTE': '1', 08:45:33 INFO - 'NO_EM_RESTART': '1', 08:45:33 INFO - 'PAGER': '/bin/cat', 08:45:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:33 INFO - 'PWD': '/builds/slave/test', 08:45:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:33 INFO - 'SHELL': '/bin/bash', 08:45:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m17MRYyF64/Listeners', 08:45:33 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 08:45:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:33 INFO - 'USER': 'cltbld', 08:45:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:33 INFO - 'XPC_FLAGS': '0x0', 08:45:33 INFO - 'XPC_SERVICE_NAME': '0', 08:45:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:45:33 INFO - Cleaning up... 08:45:33 INFO - Return code: 0 08:45:33 INFO - Running post-action listener: _resource_record_post_action 08:45:33 INFO - Running post-action listener: _start_resource_monitoring 08:45:33 INFO - Starting resource monitoring. 08:45:33 INFO - [mozharness: 2016-08-22 15:45:33.780259Z] Finished create-virtualenv step (success) 08:45:33 INFO - [mozharness: 2016-08-22 15:45:33.781262Z] Running install step. 08:45:33 INFO - Running pre-action listener: _resource_record_pre_action 08:45:33 INFO - Running main action method: install 08:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:34 INFO - Reading from file tmpfile_stdout 08:45:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:34 INFO - Reading from file tmpfile_stdout 08:45:34 INFO - Output received: 08:45:34 INFO - Usage: mozinstall [options] installer 08:45:34 INFO - Options: 08:45:34 INFO - -h, --help show this help message and exit 08:45:34 INFO - -d DEST, --destination=DEST 08:45:34 INFO - Directory to install application into. [default: 08:45:34 INFO - "/builds/slave/test"] 08:45:34 INFO - --app=APP Application being installed. [default: firefox] 08:45:34 INFO - mkdir: /builds/slave/test/build/application 08:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:46:08 INFO - Reading from file tmpfile_stdout 08:46:08 INFO - Output received: 08:46:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:46:08 INFO - Running post-action listener: _resource_record_post_action 08:46:08 INFO - [mozharness: 2016-08-22 15:46:08.180402Z] Finished install step (success) 08:46:08 INFO - [mozharness: 2016-08-22 15:46:08.180535Z] Running run-tests step. 08:46:08 INFO - Running pre-action listener: _resource_record_pre_action 08:46:08 INFO - Running main action method: run_tests 08:46:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:46:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:46:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:46:08 INFO - 2016-08-22 08:46:08.194 screenresolution[1629:7848] starting screenresolution argv=screenresolution get 08:46:08 INFO - 2016-08-22 08:46:08.196 screenresolution[1629:7848] Display 0: 1600x1200x32@60 08:46:08 INFO - 2016-08-22 08:46:08.202 screenresolution[1630:7850] starting screenresolution argv=screenresolution list 08:46:08 INFO - Available Modes on Display 0 08:46:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:46:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:46:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:46:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:46:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:46:08 INFO - Intel Iris: 08:46:08 INFO - Chipset Model: Intel Iris 08:46:08 INFO - Type: GPU 08:46:08 INFO - Bus: Built-In 08:46:08 INFO - VRAM (Dynamic, Max): 1536 MB 08:46:08 INFO - Vendor: Intel (0x8086) 08:46:08 INFO - Device ID: 0x0a2e 08:46:08 INFO - Revision ID: 0x0009 08:46:08 INFO - Displays: 08:46:08 INFO - Display: 08:46:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:46:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:46:08 INFO - Display Serial Number: 1600x1200 60 08:46:08 INFO - Main Display: Yes 08:46:08 INFO - Mirror: Off 08:46:08 INFO - Online: Yes 08:46:08 INFO - Rotation: Supported 08:46:08 INFO - Return code: 0 08:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:46:08 INFO - Python 2.7.3 08:46:08 INFO - Return code: 0 08:46:08 INFO - grabbing minidump binary from tooltool 08:46:08 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:08 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108808d30>, '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 0x10856ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108800b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:46:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:46:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:46:08 INFO - Calling ['/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'] with output_timeout 600 08:46:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:46:08 INFO - Return code: 0 08:46:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:46:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:46:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:46:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:46:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:46:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:46:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0273 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:46:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4UHtTAD7qt/Render', 08:46:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:08 INFO - 'HOME': '/Users/cltbld', 08:46:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:08 INFO - 'LOGNAME': 'cltbld', 08:46:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:46:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:08 INFO - 'MOZ_NO_REMOTE': '1', 08:46:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:46:08 INFO - 'NO_EM_RESTART': '1', 08:46:08 INFO - 'PAGER': '/bin/cat', 08:46:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:08 INFO - 'PWD': '/builds/slave/test', 08:46:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:46:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:08 INFO - 'SHELL': '/bin/bash', 08:46:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m17MRYyF64/Listeners', 08:46:08 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 08:46:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:08 INFO - 'USER': 'cltbld', 08:46:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:08 INFO - 'XPC_FLAGS': '0x0', 08:46:08 INFO - 'XPC_SERVICE_NAME': '0', 08:46:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:46:08 INFO - mozversion application_buildid: 20160822051814 08:46:08 INFO - mozversion application_changeset: 662270014cb72f82af415385f2f0bef5b135ec04 08:46:08 INFO - mozversion application_display_name: Nightly 08:46:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:46:08 INFO - mozversion application_name: Firefox 08:46:08 INFO - mozversion application_remotingname: firefox 08:46:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:46:08 INFO - mozversion application_vendor: Mozilla 08:46:08 INFO - mozversion application_version: 51.0a1 08:46:08 INFO - mozversion platform_buildid: 20160822051814 08:46:08 INFO - mozversion platform_changeset: 662270014cb72f82af415385f2f0bef5b135ec04 08:46:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:46:08 INFO - mozversion platform_version: 51.0a1 08:46:08 INFO - using testdate: 1471880768 08:46:08 INFO - actual date: 1471880768 08:46:08 INFO - starting webserver on 'localhost:49271' 08:46:08 INFO - SUITE-START | Running 2 tests 08:46:08 INFO - TEST-START | dromaeo_css 08:46:08 INFO - operating with platform_type : mac_ 08:46:08 INFO - Initialising browser for dromaeo_css test... 08:46:08 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpzbOgEf/profile http://localhost:49271/getInfo.html) 08:46:11 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 08:46:11 INFO - PROCESS | 1640 | colorDepth:24 08:46:11 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 08:46:11 INFO - PROCESS | 1640 | __metrics 08:46:11 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 08:46:12 INFO - TEST-INFO | 1640: exit 0 08:46:12 INFO - Browser initialized. 08:46:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:46:12 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpzbOgEf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:24 INFO - PROCESS | 1643 | RSS: Main: 239726592 08:46:24 INFO - PROCESS | 1643 | 08:47:14 INFO - PROCESS | 1643 | 1471880834024 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:49:25 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 08:49:27 INFO - PROCESS | 1643 | RSS: Main: 256790528 08:49:27 INFO - PROCESS | 1643 | 08:52:29 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 08:52:30 INFO - PROCESS | 1643 | RSS: Main: 266493952 08:52:30 INFO - PROCESS | 1643 | 08:55:32 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 08:55:32 INFO - PROCESS | 1643 | RSS: Main: 275083264 08:55:32 INFO - PROCESS | 1643 | 08:58:34 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 08:58:35 INFO - PROCESS | 1643 | RSS: Main: 274513920 08:58:35 INFO - PROCESS | 1643 | 09:01:38 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 09:01:38 INFO - PROCESS | 1643 | RSS: Main: 279740416 09:01:38 INFO - PROCESS | 1643 | 09:04:41 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 09:04:41 INFO - PROCESS | 1643 | RSS: Main: 282247168 09:04:41 INFO - PROCESS | 1643 | 09:04:41 INFO - PROCESS | 1643 | __start_tp_report 09:04:41 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 09:04:41 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 09:04:41 INFO - PROCESS | 1643 | |i|pagename|runs| 09:04:41 INFO - PROCESS | 1643 | |0;dojo.html;3360.899173024809;3377.9831100844494;3392.983035084824;3393.355262500125;3402.8128452935084;5637.295338082739;5716.685582292977;5721.199032135499;5763.654180749158;5799.942000579993;5555.833325000256;5673;5719.799807006766;5752.440164126965;5892.027815410452;5192.324997750287;5238.083335416287;5239.842804715865;5275.498827611371;5289.735513224343;5312.867178320535;5332.386775520807;5332.600054995872;5344.171653393711;5380.838574842761;5079.644424890259;5110.565601923841;5174.689518628857;5199.48005199477;5207.6875387476875;5212.29633999409;5239.318888544465;5240.266362709223;5254.8686282842855;5255.816046438395;5161.251618515332;5188.792448302063;5195.376554813409;5217.530422261977;5225.425203227642;4731.4795372509;5555.416681248492;5598.748056337475;5644.548436125141;5674.205611214434;5383.488568586017;6175.289841668221;6217.844553886144;6225.28409232935;6237.688115594202;6224.253089629228;6254.655993920333;6274.0902569127675;6275.843103922392;6291.559590828644;5642.802501912454;5699.886002279931;5732.799352022659;5742.7702891883855;5807.912881306784;6256.6871656417;6284.12022316876;6290.685465726695;6291.150694656163;6299.748010079637;6105;6125.96937015321;6137.815865523952;6141.631502109888;6150.907736383958;5116.232565115188;6036.728347224385;6113.602615829956;6125.571210015256;6135.877282454326;5969.671668058211;6081.513478921675;6144.446999770043;6144.907826382608;6150.78472253478;6214.9689251553455;6218.5647004709235;6230.470410015108;6243.40687634683;6261.342559031327;4768.260919557474;4867;4915.21356582945;4918.5819205367225;4928.6303527235605;3569.607343192247;3703.9259214816093;4353.1293741251875;4389.100234451929;4412.139632771643;5667.744951477193;5719.8570035749435;5728.198052272685;5733.254676892061;5735.655860648374;5723.914141287884;6196.008638617799;6222.408871157233;6227;6242.500599951993;5616.764311851386;5623.156526521055;5647;5698.800541981093;5718.571107166979;4261.698682711301;4528.547145285445;4636.258198688193;4704.7062057934345;5394.460553944574;5973.432523910222;6356.364363563699;6371.139896113966;6376.776812811437;6442.162518872517;5557.666540007613;6133.44798968095;6207.6585787782105;6208.81373558794;6216.875662486816;5231.450697676689;5247.842564723064;5717.571182161271;6148.923938310867;6353.110564521063;5529;5923.318818335774;6087.756489740361;6143.907841382472;6154.723037463415;5016.648834581691;6145.539084568586;6182.412670796267;6216.627002379872;6247.062940558771;6053.545984051302;6070.332263451105;6078.300995385587;6084.574079814371;6092.878142437038;4548.317752337176;5882.088276317178;6093.6039157454625;6105.9084113737445;6111.663858487826;5785.4873198904925;5787.363390027178;5844.12338149281;5871.1486834409625;5969.074793407029;6048.395160483917;6064.181335519825;6088.178095957166;6092.421219984094;6094.573379863545;5753.079507278982;5943.346231914399;6005.759769609167;6007.068904319663;6014.849628759316 09:04:41 INFO - PROCESS | 1643 | |1;ext.html;460.2566854529934;493.23302264977946;524.3524247554273;546.2843674786029;560.2436710440903;35562.466563001544;40024.39963400548;41854;41983.950401239985;42071.36892946608;34554.48168277471;42571.14857702844;43390;43400.13199736003;43433.56566434335;8414.87377689332;9145.679901203459;12230.571929982452;12511.18677285978;12526.123171378007;12199.817002744921;12219.389030548482;12292.016638668885;12308.507659693601;12357.443915023801;12348.320842353667;12366.752664946696;12373.195742276723;12384.566540171096;12388.62834114978;12184.634460966185;12305.261684298926;12308.323042232674;12309.384530773426;12327.876721232762;12147;12297.200681955645;12310.199837010656;12316.630501084981;12333.136680432373;41859.79070104661;42248.1550368994;42285.154296914196;42322.78838605787;42378.72863814091;3495.242117816597;3495.6504349565093;3511.666391692785;3757.9436308455397;4113.197926404352;25600.487990240275;32580;32716.509252361233;33341.499877501854;33416.16459588506;3307.6416205746605;3318.5851768528933;3329.067860998924;3350.6816852398983;3470.7917524948584;515826;525281;525468.9999999962;525531;529248;63745;64195.358046418936;64235.678821606525;64236.67881660562;64394;66306.33693663098;66521.33478665151;66582.66708666523;66618;66912;14992.550223493312;16441.506754797138;16494.42269520561;16924.492265232064;16961.830381696273;12752.916002139737;12871.613851584467;13036.80444793329;13091.541796037283;13127.540536081191;16070.517884463485;16090.195490225677;16132.354705811636;16171.595710107342;16214.432494862858;5545;5562.554995600342;6478.190226221723;6522.977876858189;6541.28045914949;890.528020149322;908.5820522559565;935.9953200234091;1002.4837208837455;1003.9909890560086;29596.408071838443;30537.847310763304;30835.383292334027;30875.38249235003;31528.896488623246;992.950352482373;1015.5836107196014;1021.2953062386929;1036.5646428500047;1037.5797801890246;14898.702025959421;15991.36034558628;16133.596660083593;16140.435084771976;16257.674846503003;682337;686139;687433;689149;690966;62803.74392512124;62827.37172628307;63223.6838815803;63595.68202158959;63957.68021159864;1076.6178006807627;1336.9799453008213;1367.7606418876658;1375.9036867419384;1381.5095641047485;29462.852685736434;30520.596386319747;30691;31458.842705786323;31880.6811931887;54418.72790636022;54529.72735136458;54923.450765491834;54964.90070198654;54992;609089;612280.5701800416;612487;615713;617606;42762.5723742771;43258.35112473252;43992.34011489894;44014.55985440233;44248.672539823856;49077.754611226715;50302.74243143951;50567.47162641927;50896.49103508917;50931.745341273054;30410.695893040785;40056.79971600123;41039.794801025804;43622.56377436185;44118.558814411444;40550.79724601358;40825;41016.38475422931;41101.79449102735;42172.73481795551;34456.65543344535;34950;38768.03079923025;39674.801625991684;40175.79912100538;35230.47154292637;35656;35841;36545.903622891354;36651;26353.4729305409;26585.468290634464;26713.058084254477;26826.597601036392;26845.328866777705 09:04:41 INFO - PROCESS | 1643 | |2;jquery.html;370.27795798193523;373.641304347826;374.397220475035;387.6201322703748;401.54224184429756;18907;19370;21743.891280543576;21837;22012.449688757788;11917.702057448569;12323.5070597176;12368.319742414164;12375.319357435337;19247.615047699037;5405.675659460425;5665.971670141644;5670.744816483269;5688.772449102031;5697.8005769798065;5474.753636086366;5526.92225016122;5561.805336813192;5592.86017849553;5626.071698169797;5577.191307260445;5594.860128496779;5595.944040559603;5598.804041858536;5600.243967064435;5374.435684253175;5533.750981205855;5562.054450743383;5586.050371436865;5602.719864006784;5311.309529761145;5411.918821217685;5416.295881535375;5420.186971954238;5429.647072940285;13636.250006249653;13644;13814.861851381458;13869.4452221911;13956.860431395658;2261.3329067924838;2336.1823361823226;2441.0601918261596;2639.6436481075193;2766.9446611067665;10120.443375614339;12140.453679584352;12649.241045537205;14708.48520301795;16551;1885.3118611706766;1915.348781414326;2008.096356639518;2011.5675129847152;2020.454477291138;130108;135213;135787.32106339405;139224.30387848098;142324;11373.611541576196;11449.198556101159;11611.129165312635;11635.301881887113;11810;14403.855961440251;14467.78298325526;14516.709665806624;14523.419063237352;14523.419063237563;8607.397482176313;8732.214100730966;8739.388242823068;8774.868376974351;8889.599968001456;8056.7180148694515;8776.561171941377;8829.867551986725;8934.553272336358;8977.910220897838;3983.5817239190046;4553.521880202531;4582.95417045832;4597.333546542997;4632.467266264355;1760.850327722158;1836.5041438811445;1911.9617607648047;1916.377177417345;1969.6553103206882;753.6721526136148;823.9382046346548;917.1424717888796;921.6728061538191;979.3193730357476;20231.393058208276;21557.245496407864;21686.02412891392;21777.34667959964;22128.778712212992;916.4547094478775;931.6646007437317;935.6117211357347;971.8542218667116;992.1071036067597;10053.849192262122;10573.788524229472;11132.608423947007;11501.76996460066;11530.88469115315;561537;622050;623548;632359.5146072813;632830;115899.42050289694;117667;134861.3256933709;138319.30840345734;146216;987.244757760314;1019.9337043092175;1034.2863424237253;1043.9425831579335;1045.1012129568564;19042.42872713821;19898.50253743668;19915.900420498383;19930.60138797187;20012.89929053916;44254.77872610616;54628.180577292165;55542.72228638992;56017.719911400185;56303.71848140733;81509.59245203974;84048;86423;91917.54041229752;93146;8044.115147333906;8084.434089613671;8206.466579672302;8387.318096620731;8454.450460720034;9465.810683786149;12682.682932926751;13117.409716562586;13615.387307570985;13706.931465343008;11339.943300283447;11350.94324528372;11720.120990925545;11731.530738770354;11743.295402275891;11335;11338.546458141582;11566.826497602375;11655.76688466243;11726.824097638713;11369.31784092957;11503.942480287546;11697.649070527897;11873.109516786102;11910.225835320676;5507.449255074461;7385.667644956097;7471.88792168107;8182.549959752271;8445.577721113797;11092.33445993243;11155.55377784912;11743.88256117428;11793.52825886955;11836 09:04:41 INFO - PROCESS | 1643 | |3;mootools.html;1536.4622382166244;1543.1975372806141;1754.7104727719927;1801.7567628370182;1802.1710013393847;7523.774286771406;7778.455508114434;8204.384671149664;8753.43102698325;8780.385373023882;8255.958720206405;8443;8503;8543.188397102282;8547.871781923277;2335.8481698689575;2384.8688322142275;2385.6183010718287;2389.080204121417;2398.9880050599722;2351.2358483492935;2374.631932050535;2392.007316963458;2399.7960173385195;2412.3124909400826;2352.6706261123454;2367.526494701067;2371.715394152704;2387.343480542856;2387.749286324928;2336.4626135988647;2351.0830775997288;2358.2571489980687;2362.2322745107735;2363.326451961191;2359.5162991586853;2360.3980984848927;2362.5038741864228;2364.0307473935777;2369.763023697634;8517.190866867637;8525.147485251488;8560.101189375087;8609.870851937227;8611.784705382353;5164.225366195101;5324.600654950856;5328.360596728378;5334.786608535654;5347.893042139135;3570.8214589270433;3592.4072528032843;3620;3664.6701796838147;3674.2100448403453;1110.5557776889227;1111.9666410007712;1117.7764447110528;1119.865616126062;1133.076542617772;10992.890071099268;11020.724481887937;11083.833742493869;11166.609168679057;11200.495977680943;4580.473245576802;4652.209124448852;4823.638227132979;4854.635902307341;4857.125717370907;9658.90341096594;9766.414015159113;9781.755456113655;9790.706278811647;9813.607455701835;5301.973490132525;5308.071087559739;5308.336457942757;5322.3879253885525;5349.812756553502;4386.254336762758;4700.811967521261;4843.903121937541;4862.635302352338;4870.902581948341;3850.557185923599;3954.8813535593977;4003.619656132663;4006.5392479864604;4016.6987475939422;1295.747329270802;1316.6905777142365;1317.2283278989744;1323.5103011885471;1330.9467621295234;868.6091258933506;869.5782545465444;901.2609660078804;912.1653686876566;961.7209111881182;5443.510084092451;5737.799177028784;5750.108733146369;5828.737706803204;5839.708014599338;862.8964524257004;866.1944391715639;868.6916144768643;903.1961554216753;909.2180724576858;3734.6825519830577;3830.3338047949233;3837.9808100959317;3844.38489841624;3871.2451072041245;10026.69919902404;10242.897571024194;10329.380237185793;10348.275620706629;10366.274360794672;8084.595770211466;10272.845907311395;10320.380777153245;10320.845187322197;10382.792344153075;7831.6867325307485;7955.5226686399;7959.562224077616;7966.402519811153;7974.122846486882;4795.448523419851;5023.924641130313;5047.369078865142;5150.330457040561;5278.604104692086;9655.662051828152;9705.078017588317;9726.902730972883;9749.463779492196;9769.462679552693;9608.90391096108;9747.610095596097;9843.507824608598;9860.901390985999;9954.104130628279;6441.1304473895425;6757.662116894234;6796.592204467748;6935.861282774417;6999.790006299819;8165.959170204111;8211.17888211198;8289.212524810133;8290.212429819157;8299.83400332002;7201.927980720336;7330.6701198445135;7330.706771729285;7415.740449084256;7431.29402706742;7053.259407762316;7185.892211616934;7201.675924583511;7205.279472052753;7272.272772722686;6808.9659551701925;6818.727250909908;6882.002109694166;6894.586324820527;6913.412359949461;4881.292212629078;4896.1921282987905;4903.60771138301;4936.950630493649;4989.326440930428;4558.36182934396;4881.682690625098;4899.1426500363;4968.652194346361;4993 09:04:41 INFO - PROCESS | 1643 | |4;prototype.html;251.66779850597214;278.63637952472027;287.4509686498787;289.9753520950719;291.6354556803995;4878.682885612433;5422.827645827186;5553.4724201200925;5674.148877668352;5682.943170568293;4549.24937385331;4621.74580398078;4963.925541116886;5567.3040869891265;5622.650563864674;3947.3486874665646;4098.549159592442;4218.7468751874985;4221.416968636761;4229.978850105746;3262.9721637684174;3913.9804300978453;4231.957680423187;4236.449261596003;4240.109576988821;3379.594448666151;3415.7096646785053;3728.7762734236035;4064.5122585289805;4066.7966601669946;4067.6542493888205;4083.897902552445;4092.5907409258834;4098.180363927197;4116.938245926283;3107.829069401182;3400.557927469438;3494.143934736006;3503.7722548034553;3509.31568344173;4763.3569468121705;5221.503957124067;5423.403425623178;5430.266913966603;5511.200875872976;3885.7862817545024;4341.261985462479;4656;4661.766911654404;4666.27672710727;4592.724436533818;4895.6500879578;5904.350521442638;5914.940850591482;6033.637981721111;3543.2382037861726;3672.559292884844;3754.305453491113;3813.199228162089;3814.6076682011144;6188.81433556994;6196.783112591038;6210.844728881769;6266.561340706153;6319.492681561732;2931.9267018324285;3224.8065116093107;3352.9773419107405;3638.9636103639154;3822.866199682998;3613.7289703271836;3811.618838116166;3918.7655888395066;3919.2553414851086;3946.3685810270217;4092.570280120604;4339.853606135526;4599.425071866017;4629;4656.906861862743;5517.586181036358;5815.651060936358;5838;5916.792912248051;5922.7927022554;1112.2214449885112;1287.8795447960147;1315.5658632651202;1328.8936885049172;1329.4682127149217;728.726727477196;768.4659161882549;826.9462484938459;851.3827475080641;886.6940905387631;5364.597655175878;5394.973025134849;5398.298221231294;5411.621186516984;5420.6691122817565;4987.825426110141;5446.754896029688;5806.635440671439;6000.429959153874;6021.397860214031;4723.6929599575915;5067.442581316052;5337.8131765388025;5357.624966252403;5411.56707463402;2445.315311712723;2667.6131960865564;2705.377763114495;2707.5261829179813;2730.4539092181644;4383.62739167168;5119.467567378497;5238.556575412188;5318.44156363584;5373;4343.218220720238;4496.078303947683;4607.562281583244;4677.497538816717;4910.402141558626;5064.417591976896;5280.788768449219;5287.524122828964;5297.867553311121;5307.946920530745;4722.929156062593;4768.666193366431;5081.4918508148885;5082.949170508247;5116;4202.642775364128;4798.987021209162;4921.3356196912955;5031.597472202142;5105;4421.889452763707;4822.373091498082;4906.386701662293;5005.249212618136;5263.34208223972;2997.415503976704;3336.182635254378;3354.580677415323;3388.9152771180916;3398.9830050849587;4403.691741578059;4429.9778501107285;4437.689361744647;5068.619853511075;5100.8469745906195;4722.52774722525;4788.760561971818;4834.830780922651;4906.0433215522635;4988.625853060962;4266.954596123969;4538.500764915791;4552.521985191507;4783.808647654055;4953.216841936972;4479.59683628475;4513.781279054571;4843.903121937471;4870.879697669485;5223.973880130575;5872.94127058741;5937.109433584997;5941.613795103304;5950;5979.880402392015;5805.274340707411;5844.532437405082;5881.705914704162;5888;5920.73356698941 09:04:41 INFO - PROCESS | 1643 | |5;yui.html;716.2765606737194;729.4018904498311;739.6412739821186;782.1435528096736;829.2329595124509;15165.317560709767;15473.845261547382;15744.134072626;15760.527184184464;15797.684046319067;14744.410223591043;14886.627834304149;14900.25498725062;14908.478203262888;14929.552113436586;685.2496516314652;835.5529791561515;848.7411339541422;873.1094283830521;878.97802554936;842.4018946547927;870.0864092702668;874.3180319350917;874.5714599846093;875.4615911214589;740.4409670698642;909.4906852162777;936.2322895225917;939.6006697153716;946.2240962410826;704.2675617357942;935.8455854783953;936.6768464879606;936.9765755856158;943.0946291560076;699.1610067918518;699.8915168148945;700.3066963705945;706.2725392845377;706.8268274272837;14811;14888.62778430548;14917.254137293092;14918.2540872957;14951;12808.231506109663;14503.709925801424;14672.339744711408;14682;14690.338934747962;10922.399268040255;11743.94128029363;12187.51249950001;12283.263004219776;12601.180923240052;3933.5869733677837;3973.1259122992897;3982.6614737747327;4134.400511925754;4148.315527937887;124175;124437.37781311126;124620;125039;125693;9353.532323383804;11527.193096483334;11534.077273818075;11730.178887477794;11907.821382679267;20811.8959405202;22460.887695561418;23373.53252934932;23388;23511.41221469443;8141.8371632568205;8258.25675689191;8409.41134120618;8416.158384161658;8437.620307086196;3781.7920014399474;4371.475422949266;4462.576055274743;4472.597466228055;4612.169809434334;3199.752096682296;3507.5790905091553;3566.3402270580027;3602.1534939289245;3687;578.7771707892492;666.4535081233342;673.4309508465338;674.4435840431663;691.0636088100551;512.5489569179173;668.1914882991634;670.7283550162192;671.318611609217;687.1547995964991;7874.56689882062;8770.605322760492;9688.951555242178;9728.805423891483;9753.366031207948;575.2263205987939;615.4765461607464;641.8555824939351;671.7951024937441;686.9210040845267;3965.8017099144927;4451.198784218872;4663.370444989883;4731.976340118277;4786.686747886214;101403.49298253462;102761.97238027674;130973;132251;132983;114101;114799.42600287113;122653;125104.1234381485;129608;109405;111800.88199117905;113370;113523.86476135298;113976.86023139663;9634.614615415305;9706.660266890625;9763.853542197015;9929.007099290302;9942.403455792386;41857;57150.57123571944;58593.12110318434;59000.40999590121;61028.77942441037;89709.65435518342;94489.5275523618;95480.52259738657;97737.53393699242;98985.01014990047;12872.871271287167;13190.272385132534;13239.801402979156;13262.469501219843;13597.86402135966;12522.436490358137;14927.402903883723;14980.176090315137;15194;15667.059976401453;12718.936405317914;12821.294828784507;12887.42006609686;13038.022148339101;13465.124766890121;13890.722185556435;13955.860441395456;13997.580072597839;14006.43974241019;14543.272836358352;13567.52513662017;13827.446902123802;13848.653783655489;13947.37236824325;14019.515577790127;9675.516224188903;11214.460516105913;11218.943905280748;11291.491882865455;11301.943490282496;9656.855147172939;11004.22970392097;11416.600418985628;11563.826542601699;11724.237924534878 09:04:41 INFO - PROCESS | 1643 | __end_tp_report 09:04:41 INFO - PROCESS | 1643 | __start_cc_report 09:04:41 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,418 09:04:41 INFO - PROCESS | 1643 | __end_cc_report 09:04:41 INFO - PROCESS | 1643 | __startTimestamp1471881881966__endTimestamp 09:04:41 INFO - PROCESS | 1643 | 09:04:41 INFO - PROCESS | 1643 | ------- Summary: start ------- 09:04:41 INFO - PROCESS | 1643 | Number of tests: 6 09:04:41 INFO - PROCESS | 1643 | 09:04:41 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5637.92 Median:5763.65 stddev:676.64 (11.7%) stddev-sans-first:654.72 09:04:41 INFO - PROCESS | 1643 | Values: 3360.9 3378.0 3393.0 3393.4 3402.8 5637.3 5716.7 5721.2 5763.7 5799.9 5555.8 5673.0 5719.8 5752.4 5892.0 5192.3 5238.1 5239.8 5275.5 5289.7 5312.9 5332.4 5332.6 5344.2 5380.8 5079.6 5110.6 5174.7 5199.5 5207.7 5212.3 5239.3 5240.3 5254.9 5255.8 5161.3 5188.8 5195.4 5217.5 5225.4 4731.5 5555.4 5598.7 5644.5 5674.2 5383.5 6175.3 6217.8 6225.3 6237.7 6224.3 6254.7 6274.1 6275.8 6291.6 5642.8 5699.9 5732.8 5742.8 5807.9 6256.7 6284.1 6290.7 6291.2 6299.7 6105.0 6126.0 6137.8 6141.6 6150.9 5116.2 6036.7 6113.6 6125.6 6135.9 5969.7 6081.5 6144.4 6144.9 6150.8 6215.0 6218.6 6230.5 6243.4 6261.3 4768.3 4867.0 4915.2 4918.6 4928.6 3569.6 3703.9 4353.1 4389.1 4412.1 5667.7 5719.9 5728.2 5733.3 5735.7 5723.9 6196.0 6222.4 6227.0 6242.5 5616.8 5623.2 5647.0 5698.8 5718.6 4261.7 4528.5 4636.3 4704.7 5394.5 5973.4 6356.4 6371.1 6376.8 6442.2 5557.7 6133.4 6207.7 6208.8 6216.9 5231.5 5247.8 5717.6 6148.9 6353.1 5529.0 5923.3 6087.8 6143.9 6154.7 5016.6 6145.5 6182.4 6216.6 6247.1 6053.5 6070.3 6078.3 6084.6 6092.9 4548.3 5882.1 6093.6 6105.9 6111.7 5785.5 5787.4 5844.1 5871.1 5969.1 6048.4 6064.2 6088.2 6092.4 6094.6 5753.1 5943.3 6005.8 6007.1 6014.8 09:04:41 INFO - PROCESS | 1643 | 09:04:41 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:75123.53 Median:36598.45 stddev:163481.22 (446.7%) stddev-sans-first:163843.71 09:04:41 INFO - PROCESS | 1643 | Values: 460.3 493.2 524.4 546.3 560.2 35562.5 40024.4 41854.0 41984.0 42071.4 34554.5 42571.1 43390.0 43400.1 43433.6 8414.9 9145.7 12230.6 12511.2 12526.1 12199.8 12219.4 12292.0 12308.5 12357.4 12348.3 12366.8 12373.2 12384.6 12388.6 12184.6 12305.3 12308.3 12309.4 12327.9 12147.0 12297.2 12310.2 12316.6 12333.1 41859.8 42248.2 42285.2 42322.8 42378.7 3495.2 3495.7 3511.7 3757.9 4113.2 25600.5 32580.0 32716.5 33341.5 33416.2 3307.6 3318.6 3329.1 3350.7 3470.8 515826.0 525281.0 525469.0 525531.0 529248.0 63745.0 64195.4 64235.7 64236.7 64394.0 66306.3 66521.3 66582.7 66618.0 66912.0 14992.6 16441.5 16494.4 16924.5 16961.8 12752.9 12871.6 13036.8 13091.5 13127.5 16070.5 16090.2 16132.4 16171.6 16214.4 5545.0 5562.6 6478.2 6523.0 6541.3 890.5 908.6 936.0 1002.5 1004.0 29596.4 30537.8 30835.4 30875.4 31528.9 993.0 1015.6 1021.3 1036.6 1037.6 14898.7 15991.4 16133.6 16140.4 16257.7 682337.0 686139.0 687433.0 689149.0 690966.0 62803.7 62827.4 63223.7 63595.7 63957.7 1076.6 1337.0 1367.8 1375.9 1381.5 29462.9 30520.6 30691.0 31458.8 31880.7 54418.7 54529.7 54923.5 54964.9 54992.0 609089.0 612280.6 612487.0 615713.0 617606.0 42762.6 43258.4 43992.3 44014.6 44248.7 49077.8 50302.7 50567.5 50896.5 50931.7 30410.7 40056.8 41039.8 43622.6 44118.6 40550.8 40825.0 41016.4 41101.8 42172.7 34456.7 34950.0 38768.0 39674.8 40175.8 35230.5 35656.0 35841.0 36545.9 36651.0 26353.5 26585.5 26713.1 26826.6 26845.3 09:04:41 INFO - PROCESS | 1643 | 09:04:41 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:35991.77 Median:21924.72 stddev:103231.12 (470.8%) stddev-sans-first:103486.06 09:04:41 INFO - PROCESS | 1643 | Values: 370.3 373.6 374.4 387.6 401.5 18907.0 19370.0 21743.9 21837.0 22012.4 11917.7 12323.5 12368.3 12375.3 19247.6 5405.7 5666.0 5670.7 5688.8 5697.8 5474.8 5526.9 5561.8 5592.9 5626.1 5577.2 5594.9 5595.9 5598.8 5600.2 5374.4 5533.8 5562.1 5586.1 5602.7 5311.3 5411.9 5416.3 5420.2 5429.6 13636.3 13644.0 13814.9 13869.4 13956.9 2261.3 2336.2 2441.1 2639.6 2766.9 10120.4 12140.5 12649.2 14708.5 16551.0 1885.3 1915.3 2008.1 2011.6 2020.5 130108.0 135213.0 135787.3 139224.3 142324.0 11373.6 11449.2 11611.1 11635.3 11810.0 14403.9 14467.8 14516.7 14523.4 14523.4 8607.4 8732.2 8739.4 8774.9 8889.6 8056.7 8776.6 8829.9 8934.6 8977.9 3983.6 4553.5 4583.0 4597.3 4632.5 1760.9 1836.5 1912.0 1916.4 1969.7 753.7 823.9 917.1 921.7 979.3 20231.4 21557.2 21686.0 21777.3 22128.8 916.5 931.7 935.6 971.9 992.1 10053.8 10573.8 11132.6 11501.8 11530.9 561537.0 622050.0 623548.0 632359.5 632830.0 115899.4 117667.0 134861.3 138319.3 146216.0 987.2 1019.9 1034.3 1043.9 1045.1 19042.4 19898.5 19915.9 19930.6 20012.9 44254.8 54628.2 55542.7 56017.7 56303.7 81509.6 84048.0 86423.0 91917.5 93146.0 8044.1 8084.4 8206.5 8387.3 8454.5 9465.8 12682.7 13117.4 13615.4 13706.9 11339.9 11350.9 11720.1 11731.5 11743.3 11335.0 11338.5 11566.8 11655.8 11726.8 11369.3 11503.9 11697.6 11873.1 11910.2 5507.4 7385.7 7471.9 8182.5 8445.6 11092.3 11155.6 11743.9 11793.5 11836.0 09:04:41 INFO - PROCESS | 1643 | 09:04:41 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5554.38 Median:5035.65 stddev:3041.10 (60.4%) stddev-sans-first:3034.64 09:04:41 INFO - PROCESS | 1643 | Values: 1536.5 1543.2 1754.7 1801.8 1802.2 7523.8 7778.5 8204.4 8753.4 8780.4 8256.0 8443.0 8503.0 8543.2 8547.9 2335.8 2384.9 2385.6 2389.1 2399.0 2351.2 2374.6 2392.0 2399.8 2412.3 2352.7 2367.5 2371.7 2387.3 2387.7 2336.5 2351.1 2358.3 2362.2 2363.3 2359.5 2360.4 2362.5 2364.0 2369.8 8517.2 8525.1 8560.1 8609.9 8611.8 5164.2 5324.6 5328.4 5334.8 5347.9 3570.8 3592.4 3620.0 3664.7 3674.2 1110.6 1112.0 1117.8 1119.9 1133.1 10992.9 11020.7 11083.8 11166.6 11200.5 4580.5 4652.2 4823.6 4854.6 4857.1 9658.9 9766.4 9781.8 9790.7 9813.6 5302.0 5308.1 5308.3 5322.4 5349.8 4386.3 4700.8 4843.9 4862.6 4870.9 3850.6 3954.9 4003.6 4006.5 4016.7 1295.7 1316.7 1317.2 1323.5 1330.9 868.6 869.6 901.3 912.2 961.7 5443.5 5737.8 5750.1 5828.7 5839.7 862.9 866.2 868.7 903.2 909.2 3734.7 3830.3 3838.0 3844.4 3871.2 10026.7 10242.9 10329.4 10348.3 10366.3 8084.6 10272.8 10320.4 10320.8 10382.8 7831.7 7955.5 7959.6 7966.4 7974.1 4795.4 5023.9 5047.4 5150.3 5278.6 9655.7 9705.1 9726.9 9749.5 9769.5 9608.9 9747.6 9843.5 9860.9 9954.1 6441.1 6757.7 6796.6 6935.9 6999.8 8166.0 8211.2 8289.2 8290.2 8299.8 7201.9 7330.7 7330.7 7415.7 7431.3 7053.3 7185.9 7201.7 7205.3 7272.3 6809.0 6818.7 6882.0 6894.6 6913.4 4881.3 4896.2 4903.6 4937.0 4989.3 4558.4 4881.7 4899.1 4968.7 4993.0 09:04:41 INFO - PROCESS | 1643 | 09:04:41 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4371.49 Median:4743.52 stddev:1383.17 (29.2%) stddev-sans-first:1352.05 09:04:41 INFO - PROCESS | 1643 | Values: 251.7 278.6 287.5 290.0 291.6 4878.7 5422.8 5553.5 5674.1 5682.9 4549.2 4621.7 4963.9 5567.3 5622.7 3947.3 4098.5 4218.7 4221.4 4230.0 3263.0 3914.0 4232.0 4236.4 4240.1 3379.6 3415.7 3728.8 4064.5 4066.8 4067.7 4083.9 4092.6 4098.2 4116.9 3107.8 3400.6 3494.1 3503.8 3509.3 4763.4 5221.5 5423.4 5430.3 5511.2 3885.8 4341.3 4656.0 4661.8 4666.3 4592.7 4895.7 5904.4 5914.9 6033.6 3543.2 3672.6 3754.3 3813.2 3814.6 6188.8 6196.8 6210.8 6266.6 6319.5 2931.9 3224.8 3353.0 3639.0 3822.9 3613.7 3811.6 3918.8 3919.3 3946.4 4092.6 4339.9 4599.4 4629.0 4656.9 5517.6 5815.7 5838.0 5916.8 5922.8 1112.2 1287.9 1315.6 1328.9 1329.5 728.7 768.5 826.9 851.4 886.7 5364.6 5395.0 5398.3 5411.6 5420.7 4987.8 5446.8 5806.6 6000.4 6021.4 4723.7 5067.4 5337.8 5357.6 5411.6 2445.3 2667.6 2705.4 2707.5 2730.5 4383.6 5119.5 5238.6 5318.4 5373.0 4343.2 4496.1 4607.6 4677.5 4910.4 5064.4 5280.8 5287.5 5297.9 5307.9 4722.9 4768.7 5081.5 5082.9 5116.0 4202.6 4799.0 4921.3 5031.6 5105.0 4421.9 4822.4 4906.4 5005.2 5263.3 2997.4 3336.2 3354.6 3388.9 3399.0 4403.7 4430.0 4437.7 5068.6 5100.8 4722.5 4788.8 4834.8 4906.0 4988.6 4267.0 4538.5 4552.5 4783.8 4953.2 4479.6 4513.8 4843.9 4870.9 5224.0 5872.9 5937.1 5941.6 5950.0 5979.9 5805.3 5844.5 5881.7 5888.0 5920.7 09:04:41 INFO - PROCESS | 1643 | 09:04:41 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:24339.62 Median:3644.58 stddev:37991.61 (1042.4%) stddev-sans-first:38056.78 09:04:41 INFO - PROCESS | 1643 | Values: 716.3 729.4 739.6 782.1 829.2 15165.3 15473.8 15744.1 15760.5 15797.7 14744.4 14886.6 14900.3 14908.5 14929.6 685.2 835.6 848.7 873.1 879.0 842.4 870.1 874.3 874.6 875.5 740.4 909.5 936.2 939.6 946.2 704.3 935.8 936.7 937.0 943.1 699.2 699.9 700.3 706.3 706.8 14811.0 14888.6 14917.3 14918.3 14951.0 12808.2 14503.7 14672.3 14682.0 14690.3 10922.4 11743.9 12187.5 12283.3 12601.2 3933.6 3973.1 3982.7 4134.4 4148.3 124175.0 124437.4 124620.0 125039.0 125693.0 9353.5 11527.2 11534.1 11730.2 11907.8 20811.9 22460.9 23373.5 23388.0 23511.4 8141.8 8258.3 8409.4 8416.2 8437.6 3781.8 4371.5 4462.6 4472.6 4612.2 3199.8 3507.6 3566.3 3602.2 3687.0 578.8 666.5 673.4 674.4 691.1 512.5 668.2 670.7 671.3 687.2 7874.6 8770.6 9689.0 9728.8 9753.4 575.2 615.5 641.9 671.8 686.9 3965.8 4451.2 4663.4 4732.0 4786.7 101403.5 102762.0 130973.0 132251.0 132983.0 114101.0 114799.4 122653.0 125104.1 129608.0 109405.0 111800.9 113370.0 113523.9 113976.9 9634.6 9706.7 9763.9 9929.0 9942.4 41857.0 57150.6 58593.1 59000.4 61028.8 89709.7 94489.5 95480.5 97737.5 98985.0 12872.9 13190.3 13239.8 13262.5 13597.9 12522.4 14927.4 14980.2 15194.0 15667.1 12718.9 12821.3 12887.4 13038.0 13465.1 13890.7 13955.9 13997.6 14006.4 14543.3 13567.5 13827.4 13848.7 13947.4 14019.5 9675.5 11214.5 11218.9 11291.5 11301.9 9656.9 11004.2 11416.6 11563.8 11724.2 09:04:41 INFO - PROCESS | 1643 | -------- Summary: end -------- 09:04:41 INFO - PROCESS | 1643 | 09:04:42 INFO - TEST-INFO | 1643: exit 0 09:04:42 INFO - TEST-OK | dromaeo_css | took 1113789ms 09:04:42 INFO - TEST-START | kraken 09:04:42 INFO - operating with platform_type : mac_ 09:04:42 INFO - Initialising browser for kraken test... 09:04:42 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpwjRuV0/profile http://localhost:49271/getInfo.html) 09:04:45 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 09:04:45 INFO - PROCESS | 1654 | colorDepth:24 09:04:45 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 09:04:45 INFO - PROCESS | 1654 | __metrics 09:04:45 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 09:04:46 INFO - TEST-INFO | 1654: exit 0 09:04:46 INFO - Browser initialized. 09:04:46 INFO - Running cycle 1/1 for kraken test... 09:04:46 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpwjRuV0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:58 INFO - PROCESS | 1656 | RSS: Main: 239898624 09:04:58 INFO - PROCESS | 1656 | 09:05:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 09:05:02 INFO - PROCESS | 1656 | RSS: Main: 252715008 09:05:02 INFO - PROCESS | 1656 | 09:05:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 09:05:05 INFO - PROCESS | 1656 | RSS: Main: 261279744 09:05:05 INFO - PROCESS | 1656 | 09:05:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 09:05:09 INFO - PROCESS | 1656 | RSS: Main: 264245248 09:05:09 INFO - PROCESS | 1656 | 09:05:11 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 09:05:12 INFO - PROCESS | 1656 | RSS: Main: 265678848 09:05:12 INFO - PROCESS | 1656 | 09:05:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:14 INFO - PROCESS | 1656 | RSS: Main: 267272192 09:05:14 INFO - PROCESS | 1656 | 09:05:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:18 INFO - PROCESS | 1656 | RSS: Main: 267272192 09:05:18 INFO - PROCESS | 1656 | 09:05:21 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:21 INFO - PROCESS | 1656 | RSS: Main: 267501568 09:05:21 INFO - PROCESS | 1656 | 09:05:24 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 09:05:25 INFO - PROCESS | 1656 | RSS: Main: 267587584 09:05:25 INFO - PROCESS | 1656 | 09:05:27 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:27 INFO - PROCESS | 1656 | RSS: Main: 267403264 09:05:27 INFO - PROCESS | 1656 | 09:05:29 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:30 INFO - PROCESS | 1656 | RSS: Main: 267558912 09:05:30 INFO - PROCESS | 1656 | 09:05:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:33 INFO - PROCESS | 1656 | RSS: Main: 267919360 09:05:33 INFO - PROCESS | 1656 | 09:05:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:36 INFO - PROCESS | 1656 | RSS: Main: 267886592 09:05:36 INFO - PROCESS | 1656 | 09:05:39 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:40 INFO - PROCESS | 1656 | RSS: Main: 267915264 09:05:40 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 09:05:42 INFO - PROCESS | 1656 | RSS: Main: 269635584 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | __start_tp_report 09:05:42 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 09:05:42 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 09:05:42 INFO - PROCESS | 1656 | |i|pagename|runs| 09:05:42 INFO - PROCESS | 1656 | |0;ai-astar;105;116;109;118;116;113;123;162;172;142 09:05:42 INFO - PROCESS | 1656 | |1;audio-beat-detection;143;127;124;190;143;165;162;110;161;109 09:05:42 INFO - PROCESS | 1656 | |2;audio-dft;201;212;251;275;222;201;195;196;196;194 09:05:42 INFO - PROCESS | 1656 | |3;audio-fft;71;83;76;145;58;58;59;65;163;83 09:05:42 INFO - PROCESS | 1656 | |4;audio-oscillator;70;70;121;73;72;80;112;70;73;116 09:05:42 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;89;111;116;87;88;85;124;87;88;90 09:05:42 INFO - PROCESS | 1656 | |6;imaging-darkroom;95;129;104;150;150;94;96;95;95;96 09:05:42 INFO - PROCESS | 1656 | |7;imaging-desaturate;96;144;149;95;92;82;95;89;91;99 09:05:42 INFO - PROCESS | 1656 | |8;json-parse-financial;53;58;57;53;58;57;57;56;57;71 09:05:42 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;63;70;68;72;75;73;67;69;69;83 09:05:42 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;85;85;88;87;86;94;106;80;91;90 09:05:42 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;157;143;141;139;148;154;161;160;232;144 09:05:42 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;185;177;159;172;240;164;162;213;239;194 09:05:42 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;67;70;74;88;86;92;84;67;69;66 09:05:42 INFO - PROCESS | 1656 | __end_tp_report 09:05:42 INFO - PROCESS | 1656 | __start_cc_report 09:05:42 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1071 09:05:42 INFO - PROCESS | 1656 | __end_cc_report 09:05:42 INFO - PROCESS | 1656 | __startTimestamp1471881942529__endTimestamp 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | ------- Summary: start ------- 09:05:42 INFO - PROCESS | 1656 | Number of tests: 14 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:127.60 Median:120.50 stddev:23.13 (19.2%) stddev-sans-first:23.04 09:05:42 INFO - PROCESS | 1656 | Values: 105.0 116.0 109.0 118.0 116.0 113.0 123.0 162.0 172.0 142.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:152.00 stddev:26.33 (17.3%) stddev-sans-first:27.92 09:05:42 INFO - PROCESS | 1656 | Values: 143.0 127.0 124.0 190.0 143.0 165.0 162.0 110.0 161.0 109.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:214.30 Median:206.50 stddev:27.70 (13.4%) stddev-sans-first:28.96 09:05:42 INFO - PROCESS | 1656 | Values: 201.0 212.0 251.0 275.0 222.0 201.0 195.0 196.0 196.0 194.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:86.10 Median:68.00 stddev:37.25 (54.8%) stddev-sans-first:39.11 09:05:42 INFO - PROCESS | 1656 | Values: 71.0 83.0 76.0 145.0 58.0 58.0 59.0 65.0 163.0 83.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:85.70 Median:71.00 stddev:21.44 (30.2%) stddev-sans-first:21.98 09:05:42 INFO - PROCESS | 1656 | Values: 70.0 70.0 121.0 73.0 72.0 80.0 112.0 70.0 73.0 116.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:87.50 stddev:14.54 (16.6%) stddev-sans-first:15.17 09:05:42 INFO - PROCESS | 1656 | Values: 89.0 111.0 116.0 87.0 88.0 85.0 124.0 87.0 88.0 90.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:110.40 Median:95.00 stddev:23.38 (24.6%) stddev-sans-first:24.12 09:05:42 INFO - PROCESS | 1656 | Values: 95.0 129.0 104.0 150.0 150.0 94.0 96.0 95.0 95.0 96.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:103.20 Median:93.50 stddev:23.31 (24.9%) stddev-sans-first:24.58 09:05:42 INFO - PROCESS | 1656 | Values: 96.0 144.0 149.0 95.0 92.0 82.0 95.0 89.0 91.0 99.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:5.01 (8.8%) stddev-sans-first:5.02 09:05:42 INFO - PROCESS | 1656 | Values: 53.0 58.0 57.0 53.0 58.0 57.0 57.0 56.0 57.0 71.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:5.40 (7.6%) stddev-sans-first:4.92 09:05:42 INFO - PROCESS | 1656 | Values: 63.0 70.0 68.0 72.0 75.0 73.0 67.0 69.0 69.0 83.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:87.50 stddev:7.04 (8.0%) stddev-sans-first:7.30 09:05:42 INFO - PROCESS | 1656 | Values: 85.0 85.0 88.0 87.0 86.0 94.0 106.0 80.0 91.0 90.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:157.90 Median:155.50 stddev:27.24 (17.5%) stddev-sans-first:28.89 09:05:42 INFO - PROCESS | 1656 | Values: 157.0 143.0 141.0 139.0 148.0 154.0 161.0 160.0 232.0 144.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.50 Median:189.50 stddev:30.52 (16.1%) stddev-sans-first:32.30 09:05:42 INFO - PROCESS | 1656 | Values: 185.0 177.0 159.0 172.0 240.0 164.0 162.0 213.0 239.0 194.0 09:05:42 INFO - PROCESS | 1656 | 09:05:42 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.30 Median:79.00 stddev:10.08 (12.8%) stddev-sans-first:10.11 09:05:42 INFO - PROCESS | 1656 | Values: 67.0 70.0 74.0 88.0 86.0 92.0 84.0 67.0 69.0 66.0 09:05:42 INFO - PROCESS | 1656 | -------- Summary: end -------- 09:05:42 INFO - PROCESS | 1656 | 09:05:43 INFO - TEST-INFO | 1656: exit 0 09:05:43 INFO - TEST-OK | kraken | took 60749ms 09:05:43 INFO - SUITE-END | took 1174s 09:05:43 INFO - Completed test suite (00:19:34) 09:05:43 INFO - javascript benchmark 09:05:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7343.958091267461, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.899173024809, 3377.9831100844494, 3392.983035084824, 3393.355262500125, 3402.8128452935084, 5637.295338082739, 5716.685582292977, 5721.199032135499, 5763.654180749158, 5799.942000579993, 5555.833325000256, 5673.0, 5719.799807006766, 5752.440164126965, 5892.027815410452, 5192.324997750287, 5238.083335416287, 5239.842804715865, 5275.498827611371, 5289.735513224343, 5312.867178320535, 5332.386775520807, 5332.600054995872, 5344.171653393711, 5380.838574842761, 5079.644424890259, 5110.565601923841, 5174.689518628857, 5199.48005199477, 5207.6875387476875, 5212.29633999409, 5239.318888544465, 5240.266362709223, 5254.8686282842855, 5255.816046438395, 5161.251618515332, 5188.792448302063, 5195.376554813409, 5217.530422261977, 5225.425203227642, 4731.4795372509, 5555.416681248492, 5598.748056337475, 5644.548436125141, 5674.205611214434, 5383.488568586017, 6175.289841668221, 6217.844553886144, 6225.28409232935, 6237.688115594202, 6224.253089629228, 6254.655993920333, 6274.0902569127675, 6275.843103922392, 6291.559590828644, 5642.802501912454, 5699.886002279931, 5732.799352022659, 5742.7702891883855, 5807.912881306784, 6256.6871656417, 6284.12022316876, 6290.685465726695, 6291.150694656163, 6299.748010079637, 6105.0, 6125.96937015321, 6137.815865523952, 6141.631502109888, 6150.907736383958, 5116.232565115188, 6036.728347224385, 6113.602615829956, 6125.571210015256, 6135.877282454326, 5969.671668058211, 6081.513478921675, 6144.446999770043, 6144.907826382608, 6150.78472253478, 6214.9689251553455, 6218.5647004709235, 6230.470410015108, 6243.40687634683, 6261.342559031327, 4768.260919557474, 4867.0, 4915.21356582945, 4918.5819205367225, 4928.6303527235605, 3569.607343192247, 3703.9259214816093, 4353.1293741251875, 4389.100234451929, 4412.139632771643, 5667.744951477193, 5719.8570035749435, 5728.198052272685, 5733.254676892061, 5735.655860648374, 5723.914141287884, 6196.008638617799, 6222.408871157233, 6227.0, 6242.500599951993, 5616.764311851386, 5623.156526521055, 5647.0, 5698.800541981093, 5718.571107166979, 4261.698682711301, 4528.547145285445, 4636.258198688193, 4704.7062057934345, 5394.460553944574, 5973.432523910222, 6356.364363563699, 6371.139896113966, 6376.776812811437, 6442.162518872517, 5557.666540007613, 6133.44798968095, 6207.6585787782105, 6208.81373558794, 6216.875662486816, 5231.450697676689, 5247.842564723064, 5717.571182161271, 6148.923938310867, 6353.110564521063, 5529.0, 5923.318818335774, 6087.756489740361, 6143.907841382472, 6154.723037463415, 5016.648834581691, 6145.539084568586, 6182.412670796267, 6216.627002379872, 6247.062940558771, 6053.545984051302, 6070.332263451105, 6078.300995385587, 6084.574079814371, 6092.878142437038, 4548.317752337176, 5882.088276317178, 6093.6039157454625, 6105.9084113737445, 6111.663858487826, 5785.4873198904925, 5787.363390027178, 5844.12338149281, 5871.1486834409625, 5969.074793407029, 6048.395160483917, 6064.181335519825, 6088.178095957166, 6092.421219984094, 6094.573379863545, 5753.079507278982, 5943.346231914399, 6005.759769609167, 6007.068904319663, 6014.849628759316], "value": 5595.546767813645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.2566854529934, 493.23302264977946, 524.3524247554273, 546.2843674786029, 560.2436710440903, 35562.466563001544, 40024.39963400548, 41854.0, 41983.950401239985, 42071.36892946608, 34554.48168277471, 42571.14857702844, 43390.0, 43400.13199736003, 43433.56566434335, 8414.87377689332, 9145.679901203459, 12230.571929982452, 12511.18677285978, 12526.123171378007, 12199.817002744921, 12219.389030548482, 12292.016638668885, 12308.507659693601, 12357.443915023801, 12348.320842353667, 12366.752664946696, 12373.195742276723, 12384.566540171096, 12388.62834114978, 12184.634460966185, 12305.261684298926, 12308.323042232674, 12309.384530773426, 12327.876721232762, 12147.0, 12297.200681955645, 12310.199837010656, 12316.630501084981, 12333.136680432373, 41859.79070104661, 42248.1550368994, 42285.154296914196, 42322.78838605787, 42378.72863814091, 3495.242117816597, 3495.6504349565093, 3511.666391692785, 3757.9436308455397, 4113.197926404352, 25600.487990240275, 32580.0, 32716.509252361233, 33341.499877501854, 33416.16459588506, 3307.6416205746605, 3318.5851768528933, 3329.067860998924, 3350.6816852398983, 3470.7917524948584, 515826.0, 525281.0, 525468.9999999962, 525531.0, 529248.0, 63745.0, 64195.358046418936, 64235.678821606525, 64236.67881660562, 64394.0, 66306.33693663098, 66521.33478665151, 66582.66708666523, 66618.0, 66912.0, 14992.550223493312, 16441.506754797138, 16494.42269520561, 16924.492265232064, 16961.830381696273, 12752.916002139737, 12871.613851584467, 13036.80444793329, 13091.541796037283, 13127.540536081191, 16070.517884463485, 16090.195490225677, 16132.354705811636, 16171.595710107342, 16214.432494862858, 5545.0, 5562.554995600342, 6478.190226221723, 6522.977876858189, 6541.28045914949, 890.528020149322, 908.5820522559565, 935.9953200234091, 1002.4837208837455, 1003.9909890560086, 29596.408071838443, 30537.847310763304, 30835.383292334027, 30875.38249235003, 31528.896488623246, 992.950352482373, 1015.5836107196014, 1021.2953062386929, 1036.5646428500047, 1037.5797801890246, 14898.702025959421, 15991.36034558628, 16133.596660083593, 16140.435084771976, 16257.674846503003, 682337.0, 686139.0, 687433.0, 689149.0, 690966.0, 62803.74392512124, 62827.37172628307, 63223.6838815803, 63595.68202158959, 63957.68021159864, 1076.6178006807627, 1336.9799453008213, 1367.7606418876658, 1375.9036867419384, 1381.5095641047485, 29462.852685736434, 30520.596386319747, 30691.0, 31458.842705786323, 31880.6811931887, 54418.72790636022, 54529.72735136458, 54923.450765491834, 54964.90070198654, 54992.0, 609089.0, 612280.5701800416, 612487.0, 615713.0, 617606.0, 42762.5723742771, 43258.35112473252, 43992.34011489894, 44014.55985440233, 44248.672539823856, 49077.754611226715, 50302.74243143951, 50567.47162641927, 50896.49103508917, 50931.745341273054, 30410.695893040785, 40056.79971600123, 41039.794801025804, 43622.56377436185, 44118.558814411444, 40550.79724601358, 40825.0, 41016.38475422931, 41101.79449102735, 42172.73481795551, 34456.65543344535, 34950.0, 38768.03079923025, 39674.801625991684, 40175.79912100538, 35230.47154292637, 35656.0, 35841.0, 36545.903622891354, 36651.0, 26353.4729305409, 26585.468290634464, 26713.058084254477, 26826.597601036392, 26845.328866777705], "value": 21248.512198334178, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.27795798193523, 373.641304347826, 374.397220475035, 387.6201322703748, 401.54224184429756, 18907.0, 19370.0, 21743.891280543576, 21837.0, 22012.449688757788, 11917.702057448569, 12323.5070597176, 12368.319742414164, 12375.319357435337, 19247.615047699037, 5405.675659460425, 5665.971670141644, 5670.744816483269, 5688.772449102031, 5697.8005769798065, 5474.753636086366, 5526.92225016122, 5561.805336813192, 5592.86017849553, 5626.071698169797, 5577.191307260445, 5594.860128496779, 5595.944040559603, 5598.804041858536, 5600.243967064435, 5374.435684253175, 5533.750981205855, 5562.054450743383, 5586.050371436865, 5602.719864006784, 5311.309529761145, 5411.918821217685, 5416.295881535375, 5420.186971954238, 5429.647072940285, 13636.250006249653, 13644.0, 13814.861851381458, 13869.4452221911, 13956.860431395658, 2261.3329067924838, 2336.1823361823226, 2441.0601918261596, 2639.6436481075193, 2766.9446611067665, 10120.443375614339, 12140.453679584352, 12649.241045537205, 14708.48520301795, 16551.0, 1885.3118611706766, 1915.348781414326, 2008.096356639518, 2011.5675129847152, 2020.454477291138, 130108.0, 135213.0, 135787.32106339405, 139224.30387848098, 142324.0, 11373.611541576196, 11449.198556101159, 11611.129165312635, 11635.301881887113, 11810.0, 14403.855961440251, 14467.78298325526, 14516.709665806624, 14523.419063237352, 14523.419063237563, 8607.397482176313, 8732.214100730966, 8739.388242823068, 8774.868376974351, 8889.599968001456, 8056.7180148694515, 8776.561171941377, 8829.867551986725, 8934.553272336358, 8977.910220897838, 3983.5817239190046, 4553.521880202531, 4582.95417045832, 4597.333546542997, 4632.467266264355, 1760.850327722158, 1836.5041438811445, 1911.9617607648047, 1916.377177417345, 1969.6553103206882, 753.6721526136148, 823.9382046346548, 917.1424717888796, 921.6728061538191, 979.3193730357476, 20231.393058208276, 21557.245496407864, 21686.02412891392, 21777.34667959964, 22128.778712212992, 916.4547094478775, 931.6646007437317, 935.6117211357347, 971.8542218667116, 992.1071036067597, 10053.849192262122, 10573.788524229472, 11132.608423947007, 11501.76996460066, 11530.88469115315, 561537.0, 622050.0, 623548.0, 632359.5146072813, 632830.0, 115899.42050289694, 117667.0, 134861.3256933709, 138319.30840345734, 146216.0, 987.244757760314, 1019.9337043092175, 1034.2863424237253, 1043.9425831579335, 1045.1012129568564, 19042.42872713821, 19898.50253743668, 19915.900420498383, 19930.60138797187, 20012.89929053916, 44254.77872610616, 54628.180577292165, 55542.72228638992, 56017.719911400185, 56303.71848140733, 81509.59245203974, 84048.0, 86423.0, 91917.54041229752, 93146.0, 8044.115147333906, 8084.434089613671, 8206.466579672302, 8387.318096620731, 8454.450460720034, 9465.810683786149, 12682.682932926751, 13117.409716562586, 13615.387307570985, 13706.931465343008, 11339.943300283447, 11350.94324528372, 11720.120990925545, 11731.530738770354, 11743.295402275891, 11335.0, 11338.546458141582, 11566.826497602375, 11655.76688466243, 11726.824097638713, 11369.31784092957, 11503.942480287546, 11697.649070527897, 11873.109516786102, 11910.225835320676, 5507.449255074461, 7385.667644956097, 7471.88792168107, 8182.549959752271, 8445.577721113797, 11092.33445993243, 11155.55377784912, 11743.88256117428, 11793.52825886955, 11836.0], "value": 9489.949051179026, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1536.4622382166244, 1543.1975372806141, 1754.7104727719927, 1801.7567628370182, 1802.1710013393847, 7523.774286771406, 7778.455508114434, 8204.384671149664, 8753.43102698325, 8780.385373023882, 8255.958720206405, 8443.0, 8503.0, 8543.188397102282, 8547.871781923277, 2335.8481698689575, 2384.8688322142275, 2385.6183010718287, 2389.080204121417, 2398.9880050599722, 2351.2358483492935, 2374.631932050535, 2392.007316963458, 2399.7960173385195, 2412.3124909400826, 2352.6706261123454, 2367.526494701067, 2371.715394152704, 2387.343480542856, 2387.749286324928, 2336.4626135988647, 2351.0830775997288, 2358.2571489980687, 2362.2322745107735, 2363.326451961191, 2359.5162991586853, 2360.3980984848927, 2362.5038741864228, 2364.0307473935777, 2369.763023697634, 8517.190866867637, 8525.147485251488, 8560.101189375087, 8609.870851937227, 8611.784705382353, 5164.225366195101, 5324.600654950856, 5328.360596728378, 5334.786608535654, 5347.893042139135, 3570.8214589270433, 3592.4072528032843, 3620.0, 3664.6701796838147, 3674.2100448403453, 1110.5557776889227, 1111.9666410007712, 1117.7764447110528, 1119.865616126062, 1133.076542617772, 10992.890071099268, 11020.724481887937, 11083.833742493869, 11166.609168679057, 11200.495977680943, 4580.473245576802, 4652.209124448852, 4823.638227132979, 4854.635902307341, 4857.125717370907, 9658.90341096594, 9766.414015159113, 9781.755456113655, 9790.706278811647, 9813.607455701835, 5301.973490132525, 5308.071087559739, 5308.336457942757, 5322.3879253885525, 5349.812756553502, 4386.254336762758, 4700.811967521261, 4843.903121937541, 4862.635302352338, 4870.902581948341, 3850.557185923599, 3954.8813535593977, 4003.619656132663, 4006.5392479864604, 4016.6987475939422, 1295.747329270802, 1316.6905777142365, 1317.2283278989744, 1323.5103011885471, 1330.9467621295234, 868.6091258933506, 869.5782545465444, 901.2609660078804, 912.1653686876566, 961.7209111881182, 5443.510084092451, 5737.799177028784, 5750.108733146369, 5828.737706803204, 5839.708014599338, 862.8964524257004, 866.1944391715639, 868.6916144768643, 903.1961554216753, 909.2180724576858, 3734.6825519830577, 3830.3338047949233, 3837.9808100959317, 3844.38489841624, 3871.2451072041245, 10026.69919902404, 10242.897571024194, 10329.380237185793, 10348.275620706629, 10366.274360794672, 8084.595770211466, 10272.845907311395, 10320.380777153245, 10320.845187322197, 10382.792344153075, 7831.6867325307485, 7955.5226686399, 7959.562224077616, 7966.402519811153, 7974.122846486882, 4795.448523419851, 5023.924641130313, 5047.369078865142, 5150.330457040561, 5278.604104692086, 9655.662051828152, 9705.078017588317, 9726.902730972883, 9749.463779492196, 9769.462679552693, 9608.90391096108, 9747.610095596097, 9843.507824608598, 9860.901390985999, 9954.104130628279, 6441.1304473895425, 6757.662116894234, 6796.592204467748, 6935.861282774417, 6999.790006299819, 8165.959170204111, 8211.17888211198, 8289.212524810133, 8290.212429819157, 8299.83400332002, 7201.927980720336, 7330.6701198445135, 7330.706771729285, 7415.740449084256, 7431.29402706742, 7053.259407762316, 7185.892211616934, 7201.675924583511, 7205.279472052753, 7272.272772722686, 6808.9659551701925, 6818.727250909908, 6882.002109694166, 6894.586324820527, 6913.412359949461, 4881.292212629078, 4896.1921282987905, 4903.60771138301, 4936.950630493649, 4989.326440930428, 4558.36182934396, 4881.682690625098, 4899.1426500363, 4968.652194346361, 4993.0], "value": 4511.4445877923345, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.66779850597214, 278.63637952472027, 287.4509686498787, 289.9753520950719, 291.6354556803995, 4878.682885612433, 5422.827645827186, 5553.4724201200925, 5674.148877668352, 5682.943170568293, 4549.24937385331, 4621.74580398078, 4963.925541116886, 5567.3040869891265, 5622.650563864674, 3947.3486874665646, 4098.549159592442, 4218.7468751874985, 4221.416968636761, 4229.978850105746, 3262.9721637684174, 3913.9804300978453, 4231.957680423187, 4236.449261596003, 4240.109576988821, 3379.594448666151, 3415.7096646785053, 3728.7762734236035, 4064.5122585289805, 4066.7966601669946, 4067.6542493888205, 4083.897902552445, 4092.5907409258834, 4098.180363927197, 4116.938245926283, 3107.829069401182, 3400.557927469438, 3494.143934736006, 3503.7722548034553, 3509.31568344173, 4763.3569468121705, 5221.503957124067, 5423.403425623178, 5430.266913966603, 5511.200875872976, 3885.7862817545024, 4341.261985462479, 4656.0, 4661.766911654404, 4666.27672710727, 4592.724436533818, 4895.6500879578, 5904.350521442638, 5914.940850591482, 6033.637981721111, 3543.2382037861726, 3672.559292884844, 3754.305453491113, 3813.199228162089, 3814.6076682011144, 6188.81433556994, 6196.783112591038, 6210.844728881769, 6266.561340706153, 6319.492681561732, 2931.9267018324285, 3224.8065116093107, 3352.9773419107405, 3638.9636103639154, 3822.866199682998, 3613.7289703271836, 3811.618838116166, 3918.7655888395066, 3919.2553414851086, 3946.3685810270217, 4092.570280120604, 4339.853606135526, 4599.425071866017, 4629.0, 4656.906861862743, 5517.586181036358, 5815.651060936358, 5838.0, 5916.792912248051, 5922.7927022554, 1112.2214449885112, 1287.8795447960147, 1315.5658632651202, 1328.8936885049172, 1329.4682127149217, 728.726727477196, 768.4659161882549, 826.9462484938459, 851.3827475080641, 886.6940905387631, 5364.597655175878, 5394.973025134849, 5398.298221231294, 5411.621186516984, 5420.6691122817565, 4987.825426110141, 5446.754896029688, 5806.635440671439, 6000.429959153874, 6021.397860214031, 4723.6929599575915, 5067.442581316052, 5337.8131765388025, 5357.624966252403, 5411.56707463402, 2445.315311712723, 2667.6131960865564, 2705.377763114495, 2707.5261829179813, 2730.4539092181644, 4383.62739167168, 5119.467567378497, 5238.556575412188, 5318.44156363584, 5373.0, 4343.218220720238, 4496.078303947683, 4607.562281583244, 4677.497538816717, 4910.402141558626, 5064.417591976896, 5280.788768449219, 5287.524122828964, 5297.867553311121, 5307.946920530745, 4722.929156062593, 4768.666193366431, 5081.4918508148885, 5082.949170508247, 5116.0, 4202.642775364128, 4798.987021209162, 4921.3356196912955, 5031.597472202142, 5105.0, 4421.889452763707, 4822.373091498082, 4906.386701662293, 5005.249212618136, 5263.34208223972, 2997.415503976704, 3336.182635254378, 3354.580677415323, 3388.9152771180916, 3398.9830050849587, 4403.691741578059, 4429.9778501107285, 4437.689361744647, 5068.619853511075, 5100.8469745906195, 4722.52774722525, 4788.760561971818, 4834.830780922651, 4906.0433215522635, 4988.625853060962, 4266.954596123969, 4538.500764915791, 4552.521985191507, 4783.808647654055, 4953.216841936972, 4479.59683628475, 4513.781279054571, 4843.903121937471, 4870.879697669485, 5223.973880130575, 5872.94127058741, 5937.109433584997, 5941.613795103304, 5950.0, 5979.880402392015, 5805.274340707411, 5844.532437405082, 5881.705914704162, 5888.0, 5920.73356698941], "value": 3924.7236066865867, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.2765606737194, 729.4018904498311, 739.6412739821186, 782.1435528096736, 829.2329595124509, 15165.317560709767, 15473.845261547382, 15744.134072626, 15760.527184184464, 15797.684046319067, 14744.410223591043, 14886.627834304149, 14900.25498725062, 14908.478203262888, 14929.552113436586, 685.2496516314652, 835.5529791561515, 848.7411339541422, 873.1094283830521, 878.97802554936, 842.4018946547927, 870.0864092702668, 874.3180319350917, 874.5714599846093, 875.4615911214589, 740.4409670698642, 909.4906852162777, 936.2322895225917, 939.6006697153716, 946.2240962410826, 704.2675617357942, 935.8455854783953, 936.6768464879606, 936.9765755856158, 943.0946291560076, 699.1610067918518, 699.8915168148945, 700.3066963705945, 706.2725392845377, 706.8268274272837, 14811.0, 14888.62778430548, 14917.254137293092, 14918.2540872957, 14951.0, 12808.231506109663, 14503.709925801424, 14672.339744711408, 14682.0, 14690.338934747962, 10922.399268040255, 11743.94128029363, 12187.51249950001, 12283.263004219776, 12601.180923240052, 3933.5869733677837, 3973.1259122992897, 3982.6614737747327, 4134.400511925754, 4148.315527937887, 124175.0, 124437.37781311126, 124620.0, 125039.0, 125693.0, 9353.532323383804, 11527.193096483334, 11534.077273818075, 11730.178887477794, 11907.821382679267, 20811.8959405202, 22460.887695561418, 23373.53252934932, 23388.0, 23511.41221469443, 8141.8371632568205, 8258.25675689191, 8409.41134120618, 8416.158384161658, 8437.620307086196, 3781.7920014399474, 4371.475422949266, 4462.576055274743, 4472.597466228055, 4612.169809434334, 3199.752096682296, 3507.5790905091553, 3566.3402270580027, 3602.1534939289245, 3687.0, 578.7771707892492, 666.4535081233342, 673.4309508465338, 674.4435840431663, 691.0636088100551, 512.5489569179173, 668.1914882991634, 670.7283550162192, 671.318611609217, 687.1547995964991, 7874.56689882062, 8770.605322760492, 9688.951555242178, 9728.805423891483, 9753.366031207948, 575.2263205987939, 615.4765461607464, 641.8555824939351, 671.7951024937441, 686.9210040845267, 3965.8017099144927, 4451.198784218872, 4663.370444989883, 4731.976340118277, 4786.686747886214, 101403.49298253462, 102761.97238027674, 130973.0, 132251.0, 132983.0, 114101.0, 114799.42600287113, 122653.0, 125104.1234381485, 129608.0, 109405.0, 111800.88199117905, 113370.0, 113523.86476135298, 113976.86023139663, 9634.614615415305, 9706.660266890625, 9763.853542197015, 9929.007099290302, 9942.403455792386, 41857.0, 57150.57123571944, 58593.12110318434, 59000.40999590121, 61028.77942441037, 89709.65435518342, 94489.5275523618, 95480.52259738657, 97737.53393699242, 98985.01014990047, 12872.871271287167, 13190.272385132534, 13239.801402979156, 13262.469501219843, 13597.86402135966, 12522.436490358137, 14927.402903883723, 14980.176090315137, 15194.0, 15667.059976401453, 12718.936405317914, 12821.294828784507, 12887.42006609686, 13038.022148339101, 13465.124766890121, 13890.722185556435, 13955.860441395456, 13997.580072597839, 14006.43974241019, 14543.272836358352, 13567.52513662017, 13827.446902123802, 13848.653783655489, 13947.37236824325, 14019.515577790127, 9675.516224188903, 11214.460516105913, 11218.943905280748, 11291.491882865455, 11301.943490282496, 9656.855147172939, 11004.22970392097, 11416.600418985628, 11563.826542601699, 11724.237924534878], "value": 7851.818995008409, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1609.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 109.0, 118.0, 116.0, 113.0, 123.0, 162.0, 172.0, 142.0], "value": 127.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 127.0, 124.0, 190.0, 143.0, 165.0, 162.0, 110.0, 161.0, 109.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 212.0, 251.0, 275.0, 222.0, 201.0, 195.0, 196.0, 196.0, 194.0], "value": 214.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 76.0, 145.0, 58.0, 58.0, 59.0, 65.0, 163.0, 83.0], "value": 86.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 121.0, 73.0, 72.0, 80.0, 112.0, 70.0, 73.0, 116.0], "value": 85.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 111.0, 116.0, 87.0, 88.0, 85.0, 124.0, 87.0, 88.0, 90.0], "value": 96.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 129.0, 104.0, 150.0, 150.0, 94.0, 96.0, 95.0, 95.0, 96.0], "value": 110.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 144.0, 149.0, 95.0, 92.0, 82.0, 95.0, 89.0, 91.0, 99.0], "value": 103.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 57.0, 53.0, 58.0, 57.0, 57.0, 56.0, 57.0, 71.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 68.0, 72.0, 75.0, 73.0, 67.0, 69.0, 69.0, 83.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 88.0, 87.0, 86.0, 94.0, 106.0, 80.0, 91.0, 90.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 143.0, 141.0, 139.0, 148.0, 154.0, 161.0, 160.0, 232.0, 144.0], "value": 157.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 177.0, 159.0, 172.0, 240.0, 164.0, 162.0, 213.0, 239.0, 194.0], "value": 190.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 74.0, 88.0, 86.0, 92.0, 84.0, 67.0, 69.0, 66.0], "value": 76.3, "unit": "score"}]}]} 09:05:43 INFO - Return code: 0 09:05:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:05:43 ERROR - # TBPL SUCCESS # 09:05:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:05:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:05:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:05:43 INFO - 2016-08-22 09:05:43.849 screenresolution[1661:11070] starting screenresolution argv=screenresolution get 09:05:43 INFO - 2016-08-22 09:05:43.852 screenresolution[1661:11070] Display 0: 1600x1200x32@60 09:05:43 INFO - 2016-08-22 09:05:43.857 screenresolution[1662:11073] starting screenresolution argv=screenresolution list 09:05:43 INFO - Available Modes on Display 0 09:05:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:05:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:05:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:05:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:05:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:05:44 INFO - Intel Iris: 09:05:44 INFO - Chipset Model: Intel Iris 09:05:44 INFO - Type: GPU 09:05:44 INFO - Bus: Built-In 09:05:44 INFO - VRAM (Dynamic, Max): 1536 MB 09:05:44 INFO - Vendor: Intel (0x8086) 09:05:44 INFO - Device ID: 0x0a2e 09:05:44 INFO - Revision ID: 0x0009 09:05:44 INFO - Displays: 09:05:44 INFO - Display: 09:05:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:05:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:05:44 INFO - Display Serial Number: 1600x1200 60 09:05:44 INFO - Main Display: Yes 09:05:44 INFO - Mirror: Off 09:05:44 INFO - Online: Yes 09:05:44 INFO - Rotation: Supported 09:05:44 INFO - Return code: 0 09:05:44 INFO - Running post-action listener: _resource_record_post_action 09:05:44 INFO - [mozharness: 2016-08-22 16:05:44.093383Z] Finished run-tests step (success) 09:05:44 INFO - Running post-run listener: _resource_record_post_run 09:05:44 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 37295104; Write bytes: 708113408; Read time: 241; Write time: 2055 09:05:44 INFO - TinderboxPrint: CPU usage
55.0% 09:05:44 INFO - TinderboxPrint: I/O read bytes / time
37,295,104 / 241 09:05:44 INFO - TinderboxPrint: I/O write bytes / time
708,113,408 / 2,055 09:05:44 INFO - TinderboxPrint: CPU idle
2,178.9 (45.0%) 09:05:44 INFO - TinderboxPrint: CPU system
985.3 (20.4%) 09:05:44 INFO - TinderboxPrint: CPU user
1,673.4 (34.6%) 09:05:44 INFO - TinderboxPrint: Swap in / out
443,326,464 / 0 09:05:44 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399749632; Write bytes: 393660416; Read time: 29635; Write time: 813 09:05:44 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 35066880; Write bytes: 298290176; Read time: 220; Write time: 1197 09:05:44 INFO - Running post-run listener: _upload_blobber_files 09:05:44 INFO - Blob upload gear active. 09:05:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:05:44 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:05:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:46 INFO - (blobuploader) - INFO - Done attempting. 09:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:05:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:46 INFO - (blobuploader) - INFO - Done attempting. 09:05:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:05:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:49 INFO - (blobuploader) - INFO - Done attempting. 09:05:49 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:49 INFO - Return code: 0 09:05:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bdb1623d75b94bd188a64742b8aae20a5e9fde020ed9d4683dd1aeaeaa3e2a87e57cec2b0efbe3af41892fb7e465bc0ed9edb93cbc64e68ec12910a56910364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7dbbe671cb22159890b2753f7fabd52954ffdfd7edd574914a1048383e421b5b3703d398b21881400dcb276fd1118942e89abb683b5c3d5582af220a4596de1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cb9322653334f2a987d4c99f3d785d28a77b859833acb936ae16e97f4780aa6ff7a573a4ad2dcaffbbe0c42b24df34241ff24579b756e0985bf6ea95dbd5c0b"} 09:05:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:49 INFO - Contents: 09:05:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bdb1623d75b94bd188a64742b8aae20a5e9fde020ed9d4683dd1aeaeaa3e2a87e57cec2b0efbe3af41892fb7e465bc0ed9edb93cbc64e68ec12910a56910364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7dbbe671cb22159890b2753f7fabd52954ffdfd7edd574914a1048383e421b5b3703d398b21881400dcb276fd1118942e89abb683b5c3d5582af220a4596de1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cb9322653334f2a987d4c99f3d785d28a77b859833acb936ae16e97f4780aa6ff7a573a4ad2dcaffbbe0c42b24df34241ff24579b756e0985bf6ea95dbd5c0b"} 09:05:49 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:49 INFO - Copying logs to upload dir... 09:05:49 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.897473 ========= master_lag: 2.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-22 09:05:51.845037) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-08-22 09:05:51.849450) ========= 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.4UHtTAD7qt/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.m17MRYyF64/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bdb1623d75b94bd188a64742b8aae20a5e9fde020ed9d4683dd1aeaeaa3e2a87e57cec2b0efbe3af41892fb7e465bc0ed9edb93cbc64e68ec12910a56910364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7dbbe671cb22159890b2753f7fabd52954ffdfd7edd574914a1048383e421b5b3703d398b21881400dcb276fd1118942e89abb683b5c3d5582af220a4596de1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cb9322653334f2a987d4c99f3d785d28a77b859833acb936ae16e97f4780aa6ff7a573a4ad2dcaffbbe0c42b24df34241ff24579b756e0985bf6ea95dbd5c0b"} build_url:https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010591 build_url: 'https://queue.taskcluster.net/v1/task/fa6-kE6iRkaO9eNB7PerUg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bdb1623d75b94bd188a64742b8aae20a5e9fde020ed9d4683dd1aeaeaa3e2a87e57cec2b0efbe3af41892fb7e465bc0ed9edb93cbc64e68ec12910a56910364", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7dbbe671cb22159890b2753f7fabd52954ffdfd7edd574914a1048383e421b5b3703d398b21881400dcb276fd1118942e89abb683b5c3d5582af220a4596de1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1cb9322653334f2a987d4c99f3d785d28a77b859833acb936ae16e97f4780aa6ff7a573a4ad2dcaffbbe0c42b24df34241ff24579b756e0985bf6ea95dbd5c0b"}' ========= master_lag: 2.63 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-08-22 09:05:54.488037) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:05:54.488369) ========= 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.4UHtTAD7qt/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.m17MRYyF64/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.005176 ========= master_lag: 0.93 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 09:05:55.421938) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 09:05:55.422290) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 09:05:55.435052) ========= ========= Total master_lag: 6.07 =========