builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0082 starttime: 1476703892.94 results: success (0) buildid: 20161017021835 builduid: c329bc3ed79942b19c012c015ea55489 revision: 0191c2f3a6e8c0a241bc440cb61a8f15d061bc38 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 04:31:32.942524) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 04:31:32.942948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 04:31:32.943274) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 04:31:32.965762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 04:31:32.966106) ========= 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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-10-17 04:31:32-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 153M=0s 2016-10-17 04:31:33 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098075 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 04:31:33.087280) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 04:31:33.087800) ========= 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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.018921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 04:31:33.137718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-17 04:31:33.138059) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0191c2f3a6e8c0a241bc440cb61a8f15d061bc38 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0191c2f3a6e8c0a241bc440cb61a8f15d061bc38 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-10-17 04:31:33,213 truncating revision to first 12 chars 2016-10-17 04:31:33,213 Setting DEBUG logging. 2016-10-17 04:31:33,213 attempt 1/10 2016-10-17 04:31:33,213 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0191c2f3a6e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 04:31:34,822 unpacking tar archive at: mozilla-central-0191c2f3a6e8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.853801 ========= master_lag: 1.83 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-17 04:31:36.825838) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 04:31:36.826140) ========= script_repo_revision: 0191c2f3a6e8c0a241bc440cb61a8f15d061bc38 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 04:31:36.826584) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-10-17 04:31:36.826845) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 2 secs) (at 2016-10-17 04:31:39.417355) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-17 04:31:39.417694) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 04:31:39 INFO - MultiFileLogger online at 20161017 04:31:39 in /builds/slave/test 04:31:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:31:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:39 INFO - {'append_to_log': False, 04:31:39 INFO - 'base_work_dir': '/builds/slave/test', 04:31:39 INFO - 'blob_upload_branch': 'Firefox', 04:31:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:39 INFO - 'branch': 'Firefox', 04:31:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:39 INFO - 'config_files': ('talos/mac_config.py',), 04:31:39 INFO - 'default_actions': ('clobber', 04:31:39 INFO - 'read-buildbot-config', 04:31:39 INFO - 'download-and-extract', 04:31:39 INFO - 'populate-webroot', 04:31:39 INFO - 'create-virtualenv', 04:31:39 INFO - 'install', 04:31:39 INFO - 'run-tests'), 04:31:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:39 INFO - 'download_minidump_stackwalk': True, 04:31:39 INFO - 'download_symbols': 'ondemand', 04:31:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:39 INFO - 'installer_path': 'installer.exe', 04:31:39 INFO - 'log_level': 'info', 04:31:39 INFO - 'log_name': 'talos', 04:31:39 INFO - 'log_to_console': True, 04:31:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:31:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:31:39 INFO - 'opt_config_files': (), 04:31:39 INFO - 'pip_index': False, 04:31:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:39 INFO - 'cmd': ('bash', 04:31:39 INFO - '-c', 04:31:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:39 INFO - 'enabled': True, 04:31:39 INFO - 'halt_on_failure': False, 04:31:39 INFO - 'name': 'check_screen_resolution'},), 04:31:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:39 INFO - 'cmd': ('bash', 04:31:39 INFO - '-c', 04:31:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:39 INFO - 'enabled': True, 04:31:39 INFO - 'halt_on_failure': False, 04:31:39 INFO - 'name': 'check_screen_resolution'},), 04:31:39 INFO - 'run_cmd_checks_enabled': True, 04:31:39 INFO - 'sps_profile': False, 04:31:39 INFO - 'sps_profile_interval': 0, 04:31:39 INFO - 'suite': 'dromaeojs', 04:31:39 INFO - 'system_bits': '32', 04:31:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:39 INFO - 'title': 't-yosemite-r7-0082', 04:31:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:39 INFO - 'use_talos_json': True, 04:31:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:39 INFO - 'work_dir': 'build'} 04:31:39 INFO - [mozharness: 2016-10-17 11:31:39.631359Z] Running clobber step. 04:31:39 INFO - Running pre-action listener: _resource_record_pre_action 04:31:39 INFO - Running main action method: clobber 04:31:39 INFO - rmtree: /builds/slave/test/build 04:31:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:39 INFO - Running post-action listener: _resource_record_post_action 04:31:39 INFO - [mozharness: 2016-10-17 11:31:39.818276Z] Finished clobber step (success) 04:31:39 INFO - [mozharness: 2016-10-17 11:31:39.818396Z] Running read-buildbot-config step. 04:31:39 INFO - Running pre-action listener: _resource_record_pre_action 04:31:39 INFO - Running main action method: read_buildbot_config 04:31:39 INFO - Using buildbot properties: 04:31:39 INFO - { 04:31:39 INFO - "project": "", 04:31:39 INFO - "product": "firefox", 04:31:39 INFO - "script_repo_revision": "production", 04:31:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:31:39 INFO - "repository": "", 04:31:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:31:39 INFO - "buildid": "20161017021835", 04:31:39 INFO - "pgo_build": "False", 04:31:39 INFO - "basedir": "/builds/slave/test", 04:31:39 INFO - "buildnumber": 48, 04:31:39 INFO - "slavename": "t-yosemite-r7-0082", 04:31:39 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:31:39 INFO - "platform": "yosemite_r7", 04:31:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:31:39 INFO - "branch": "mozilla-central", 04:31:39 INFO - "repo_path": "mozilla-central", 04:31:39 INFO - "revision": "0191c2f3a6e8c0a241bc440cb61a8f15d061bc38", 04:31:39 INFO - "stage_platform": "macosx64", 04:31:39 INFO - "builduid": "c329bc3ed79942b19c012c015ea55489", 04:31:39 INFO - "slavebuilddir": "test" 04:31:39 INFO - } 04:31:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 04:31:39 INFO - Running post-action listener: _resource_record_post_action 04:31:39 INFO - [mozharness: 2016-10-17 11:31:39.821694Z] Finished read-buildbot-config step (success) 04:31:39 INFO - [mozharness: 2016-10-17 11:31:39.821809Z] Running download-and-extract step. 04:31:39 INFO - Running pre-action listener: _resource_record_pre_action 04:31:39 INFO - Running main action method: download_and_extract 04:31:39 INFO - mkdir: /builds/slave/test/build/tests 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:39 INFO - trying https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 04:31:39 INFO - Downloading https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 04:31:41 INFO - Downloaded 1199 bytes. 04:31:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:31:41 INFO - Using the following test package requirements: 04:31:41 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:31:41 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 04:31:41 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 04:31:41 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'jsshell-mac.zip'], 04:31:41 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 04:31:41 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:31:41 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 04:31:41 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 04:31:41 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 04:31:41 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:31:41 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 04:31:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:31:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:31:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:31:41 INFO - Fetch https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:31:41 INFO - Http code: 200 04:31:41 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 04:31:41 INFO - x-amz-cf-id: XClJlHj4cKij0g_oui4a4rBOq5R7nULdLGTpPmeVC_YTINkzrIcKGQ== 04:31:41 INFO - x-amz-version-id: _uzunl2n9knjP5IV5xuJTvAIq.8EGCKO 04:31:42 INFO - Expected file size: 16509929 04:31:42 INFO - Obtained file size: 16509929 04:31:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:31:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:31:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:31:48 INFO - Fetch https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:31:49 INFO - Http code: 200 04:31:49 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 04:31:49 INFO - x-amz-cf-id: 1p4CuTGcGRMlO2-O-ly9JL4WGJ99aAtqfEy7DnVoH9yLJN9XkxsBTw== 04:31:49 INFO - x-amz-version-id: _uzunl2n9knjP5IV5xuJTvAIq.8EGCKO 04:31:49 INFO - Expected file size: 16509929 04:31:49 INFO - Obtained file size: 16509929 04:31:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 04:31:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:31:55 INFO - Fetch https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 04:31:57 INFO - Http code: 200 04:31:57 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 04:31:57 INFO - x-amz-cf-id: fyOQtZJRD_IiuXBZkqAcxgC49hPkIvlCljSYJZNp6nBbj_qykmFpEw== 04:31:57 INFO - x-amz-version-id: cm6GxxK3tCXmjlKQ1pGNYrm11PJaHLBo 04:31:57 INFO - Expected file size: 14409028 04:31:57 INFO - Obtained file size: 14409028 04:31: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')]} 04:31:57 INFO - trying https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:31:57 INFO - Downloading https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 04:31:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 04:32:00 INFO - Downloaded 111640283 bytes. 04:32:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:32:00 INFO - mkdir: /builds/slave/test/properties 04:32:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:00 INFO - Contents: 04:32:00 INFO - build_url:https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:32:01 INFO - Running post-action listener: _resource_record_post_action 04:32:01 INFO - Running post-action listener: set_extra_try_arguments 04:32:01 INFO - [mozharness: 2016-10-17 11:32:01.368786Z] Finished download-and-extract step (success) 04:32:01 INFO - [mozharness: 2016-10-17 11:32:01.368921Z] Running populate-webroot step. 04:32:01 INFO - Running pre-action listener: _resource_record_pre_action 04:32:01 INFO - Running main action method: populate_webroot 04:32:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:01 INFO - '--tppagecycles', 04:32:01 INFO - '7'], 04:32:01 INFO - 'tests': ['tsvgm']}}, 04:32:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:32:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:32:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:32:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:32:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:01 INFO - 'talos_options': ['--disable-e10s'], 04:32:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:01 INFO - 'talos_options': ['--disable-e10s'], 04:32:01 INFO - 'tests': ['damp', 'tps']}, 04:32:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:01 INFO - 'tests': ['damp', 'tps']}, 04:32:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:32:01 INFO - 'tests': ['dromaeo_dom']}, 04:32:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:32:01 INFO - 'tests': ['basic_compositor_video']}, 04:32:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:32:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:32:01 INFO - 'tests': ['a11yr', 04:32:01 INFO - 'ts_paint', 04:32:01 INFO - 'tpaint', 04:32:01 INFO - 'sessionrestore', 04:32:01 INFO - 'sessionrestore_no_auto_restore', 04:32:01 INFO - 'tabpaint']}, 04:32:01 INFO - 'other-e10s': {'tests': ['a11yr', 04:32:01 INFO - 'ts_paint', 04:32:01 INFO - 'tpaint', 04:32:01 INFO - 'sessionrestore', 04:32:01 INFO - 'sessionrestore_no_auto_restore', 04:32:01 INFO - 'tabpaint']}, 04:32:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:32:01 INFO - 'ts_paint', 04:32:01 INFO - 'tpaint', 04:32:01 INFO - 'sessionrestore', 04:32:01 INFO - 'sessionrestore_no_auto_restore', 04:32:01 INFO - 'tabpaint']}, 04:32:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:32:01 INFO - 'ts_paint', 04:32:01 INFO - 'tpaint', 04:32:01 INFO - 'sessionrestore', 04:32:01 INFO - 'sessionrestore_no_auto_restore', 04:32:01 INFO - 'tabpaint']}, 04:32:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:32:01 INFO - 'tests': ['a11yr', 04:32:01 INFO - 'ts_paint', 04:32:01 INFO - 'tpaint', 04:32:01 INFO - 'sessionrestore', 04:32:01 INFO - 'sessionrestore_no_auto_restore', 04:32:01 INFO - 'tabpaint']}, 04:32:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:32:01 INFO - 'tests': ['a11yr', 04:32:01 INFO - 'ts_paint', 04:32:01 INFO - 'tpaint', 04:32:01 INFO - 'sessionrestore', 04:32:01 INFO - 'sessionrestore_no_auto_restore', 04:32:01 INFO - 'tabpaint']}, 04:32:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:32:01 INFO - 'tests': ['tsvgx', 04:32:01 INFO - 'tsvgr_opacity', 04:32:01 INFO - 'tart', 04:32:01 INFO - 'tscrollx', 04:32:01 INFO - 'cart']}, 04:32:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:32:01 INFO - 'tsvgr_opacity', 04:32:01 INFO - 'tart', 04:32:01 INFO - 'tscrollx', 04:32:01 INFO - 'cart']}, 04:32:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:01 INFO - 'talos_options': ['--disable-e10s'], 04:32:01 INFO - 'tests': ['tp5o']}, 04:32:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:01 INFO - 'tests': ['tp5o']}, 04:32:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:01 INFO - 'talos_options': ['--disable-e10s', 04:32:01 INFO - '--xperf_path', 04:32:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:01 INFO - 'tests': ['tp5n']}, 04:32:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:01 INFO - 'talos_options': ['--xperf_path', 04:32:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:01 INFO - 'tests': ['tp5n']}}, 04:32:01 INFO - 'talos.zip': {'path': '', 04:32:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:01 INFO - Running post-action listener: _resource_record_post_action 04:32:01 INFO - [mozharness: 2016-10-17 11:32:01.388033Z] Finished populate-webroot step (success) 04:32:01 INFO - [mozharness: 2016-10-17 11:32:01.388163Z] Running create-virtualenv step. 04:32:01 INFO - Running pre-action listener: _resource_record_pre_action 04:32:01 INFO - Running main action method: create_virtualenv 04:32:01 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:01 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 04:32:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:01 INFO - Using real prefix '/tools/python27' 04:32:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:02 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:05 INFO - Installing pip.................done. 04:32:05 INFO - Return code: 0 04:32:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:32:05 INFO - Reading from file tmpfile_stdout 04:32:05 INFO - Output received: 04:32:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:32:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:05 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 0x105f10490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e86570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1bcc57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d24d30>, '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 0x105b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1cb20>, '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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 04:32:05 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 04:32:05 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 04:32:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmdmxHKoCf/Render', 04:32:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:05 INFO - 'HOME': '/Users/cltbld', 04:32:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:05 INFO - 'LOGNAME': 'cltbld', 04:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:05 INFO - 'MOZ_NO_REMOTE': '1', 04:32:05 INFO - 'NO_EM_RESTART': '1', 04:32:05 INFO - 'PAGER': '/bin/cat', 04:32:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:05 INFO - 'PWD': '/builds/slave/test', 04:32:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:05 INFO - 'SHELL': '/bin/bash', 04:32:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gN6uq8Nj9a/Listeners', 04:32:05 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 04:32:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:05 INFO - 'USER': 'cltbld', 04:32:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:05 INFO - 'XPC_FLAGS': '0x0', 04:32:05 INFO - 'XPC_SERVICE_NAME': '0', 04:32:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:05 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 04:32:05 INFO - Cleaning up... 04:32:05 INFO - Return code: 0 04:32:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:05 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 0x105f10490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e86570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1bcc57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d24d30>, '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 0x105b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1cb20>, '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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 04:32:05 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 04:32:05 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 04:32:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmdmxHKoCf/Render', 04:32:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:05 INFO - 'HOME': '/Users/cltbld', 04:32:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:05 INFO - 'LOGNAME': 'cltbld', 04:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:05 INFO - 'MOZ_NO_REMOTE': '1', 04:32:05 INFO - 'NO_EM_RESTART': '1', 04:32:05 INFO - 'PAGER': '/bin/cat', 04:32:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:05 INFO - 'PWD': '/builds/slave/test', 04:32:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:05 INFO - 'SHELL': '/bin/bash', 04:32:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gN6uq8Nj9a/Listeners', 04:32:05 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 04:32:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:05 INFO - 'USER': 'cltbld', 04:32:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:05 INFO - 'XPC_FLAGS': '0x0', 04:32:05 INFO - 'XPC_SERVICE_NAME': '0', 04:32:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:05 INFO - Downloading/unpacking psutil>=3.1.1 04:32:05 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 04:32:05 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 04:32:05 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 04:32:05 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 04:32:05 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 04:32:05 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 04:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:09 INFO - Installing collected packages: psutil 04:32:09 INFO - Running setup.py install for psutil 04:32:09 INFO - building 'psutil._psutil_osx' extension 04:32:09 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 04:32:09 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 04:32:09 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 04:32:09 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 04:32:09 INFO - building 'psutil._psutil_posix' extension 04:32:09 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 04:32:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:09 INFO - ^ 04:32:10 INFO - 1 warning generated. 04:32:10 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 04:32:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:10 INFO - Successfully installed psutil 04:32:10 INFO - Cleaning up... 04:32:10 INFO - Return code: 0 04:32:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 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 0x105f10490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e86570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1bcc57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d24d30>, '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 0x105b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1cb20>, '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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 04:32:10 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 04:32:10 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 04:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmdmxHKoCf/Render', 04:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:10 INFO - 'HOME': '/Users/cltbld', 04:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:10 INFO - 'LOGNAME': 'cltbld', 04:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:10 INFO - 'MOZ_NO_REMOTE': '1', 04:32:10 INFO - 'NO_EM_RESTART': '1', 04:32:10 INFO - 'PAGER': '/bin/cat', 04:32:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:10 INFO - 'PWD': '/builds/slave/test', 04:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:10 INFO - 'SHELL': '/bin/bash', 04:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gN6uq8Nj9a/Listeners', 04:32:10 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 04:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:10 INFO - 'USER': 'cltbld', 04:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:10 INFO - 'XPC_FLAGS': '0x0', 04:32:10 INFO - 'XPC_SERVICE_NAME': '0', 04:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:32:10 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 04:32:10 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 04:32:10 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 04:32:10 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 04:32:10 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 04:32:10 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 04:32:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:13 INFO - Installing collected packages: mozsystemmonitor 04:32:13 INFO - Running setup.py install for mozsystemmonitor 04:32:13 INFO - Successfully installed mozsystemmonitor 04:32:13 INFO - Cleaning up... 04:32:13 INFO - Return code: 0 04:32:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:32:13 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')]} 04:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:13 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')]} 04:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:13 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 0x105f10490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e86570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1bcc57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d24d30>, '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 0x105b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1cb20>, '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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 04:32:13 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 04:32:13 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 04:32:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmdmxHKoCf/Render', 04:32:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:13 INFO - 'HOME': '/Users/cltbld', 04:32:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:13 INFO - 'LOGNAME': 'cltbld', 04:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:13 INFO - 'MOZ_NO_REMOTE': '1', 04:32:13 INFO - 'NO_EM_RESTART': '1', 04:32:13 INFO - 'PAGER': '/bin/cat', 04:32:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:13 INFO - 'PWD': '/builds/slave/test', 04:32:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:13 INFO - 'SHELL': '/bin/bash', 04:32:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gN6uq8Nj9a/Listeners', 04:32:13 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 04:32:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:13 INFO - 'USER': 'cltbld', 04:32:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:13 INFO - 'XPC_FLAGS': '0x0', 04:32:13 INFO - 'XPC_SERVICE_NAME': '0', 04:32:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:13 INFO - Downloading/unpacking jsonschema==2.5.1 04:32:13 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 04:32:13 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 04:32:13 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 04:32:13 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 04:32:13 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 04:32:13 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 04:32:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:32:16 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 04:32:16 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 04:32:16 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 04:32:16 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 04:32:16 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 04:32:16 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 04:32:16 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:16 INFO - warning: no files found matching '*.txt' 04:32:16 INFO - no previously-included directories found matching 'build' 04:32:16 INFO - no previously-included directories found matching 'dist' 04:32:16 INFO - no previously-included directories found matching '.git*' 04:32:16 INFO - Installing collected packages: jsonschema, functools32 04:32:16 INFO - Running setup.py install for functools32 04:32:16 INFO - warning: no files found matching '*.txt' 04:32:16 INFO - no previously-included directories found matching 'build' 04:32:16 INFO - no previously-included directories found matching 'dist' 04:32:16 INFO - no previously-included directories found matching '.git*' 04:32:16 INFO - Successfully installed jsonschema functools32 04:32:16 INFO - Cleaning up... 04:32:16 INFO - Return code: 0 04:32:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:32:16 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')]} 04:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:16 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')]} 04:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:16 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 0x105f10490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e86570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1bcc57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d24d30>, '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 0x105b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1cb20>, '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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 04:32:16 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 04:32:16 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 04:32:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmdmxHKoCf/Render', 04:32:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:16 INFO - 'HOME': '/Users/cltbld', 04:32:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:16 INFO - 'LOGNAME': 'cltbld', 04:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:16 INFO - 'MOZ_NO_REMOTE': '1', 04:32:16 INFO - 'NO_EM_RESTART': '1', 04:32:16 INFO - 'PAGER': '/bin/cat', 04:32:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:16 INFO - 'PWD': '/builds/slave/test', 04:32:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:16 INFO - 'SHELL': '/bin/bash', 04:32:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gN6uq8Nj9a/Listeners', 04:32:16 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 04:32:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:16 INFO - 'USER': 'cltbld', 04:32:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:16 INFO - 'XPC_FLAGS': '0x0', 04:32:16 INFO - 'XPC_SERVICE_NAME': '0', 04:32:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:32:17 INFO - Cleaning up... 04:32:17 INFO - Return code: 0 04:32:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:17 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 0x105f10490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e86570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1bcc57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d24d30>, '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 0x105b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1cb20>, '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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 04:32:17 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 04:32:17 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 04:32:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmdmxHKoCf/Render', 04:32:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:17 INFO - 'HOME': '/Users/cltbld', 04:32:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:17 INFO - 'LOGNAME': 'cltbld', 04:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:17 INFO - 'MOZ_NO_REMOTE': '1', 04:32:17 INFO - 'NO_EM_RESTART': '1', 04:32:17 INFO - 'PAGER': '/bin/cat', 04:32:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:17 INFO - 'PWD': '/builds/slave/test', 04:32:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:17 INFO - 'SHELL': '/bin/bash', 04:32:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gN6uq8Nj9a/Listeners', 04:32:17 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 04:32:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:17 INFO - 'USER': 'cltbld', 04:32:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:17 INFO - 'XPC_FLAGS': '0x0', 04:32:17 INFO - 'XPC_SERVICE_NAME': '0', 04:32:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:17 INFO - Downloading/unpacking blobuploader==1.2.4 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:19 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:19 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 04:32:19 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 04:32:19 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 04:32:19 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 04:32:19 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 04:32:19 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 04:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:20 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 04:32:20 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 04:32:20 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 04:32:20 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 04:32:20 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 04:32:20 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 04:32:21 INFO - Downloading docopt-0.6.1.tar.gz 04:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:21 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:21 INFO - Running setup.py install for blobuploader 04:32:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:21 INFO - Running setup.py install for requests 04:32:21 INFO - Running setup.py install for docopt 04:32:21 INFO - Successfully installed blobuploader requests docopt 04:32:21 INFO - Cleaning up... 04:32:22 INFO - Return code: 0 04:32:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:22 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 0x105f10490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e86570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1bcc57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d24d30>, '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 0x105b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1cb20>, '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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 04:32:22 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 04:32:22 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 04:32:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmdmxHKoCf/Render', 04:32:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:22 INFO - 'HOME': '/Users/cltbld', 04:32:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:22 INFO - 'LOGNAME': 'cltbld', 04:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:22 INFO - 'MOZ_NO_REMOTE': '1', 04:32:22 INFO - 'NO_EM_RESTART': '1', 04:32:22 INFO - 'PAGER': '/bin/cat', 04:32:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:22 INFO - 'PWD': '/builds/slave/test', 04:32:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:22 INFO - 'SHELL': '/bin/bash', 04:32:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gN6uq8Nj9a/Listeners', 04:32:22 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 04:32:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:22 INFO - 'USER': 'cltbld', 04:32:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:22 INFO - 'XPC_FLAGS': '0x0', 04:32:22 INFO - 'XPC_SERVICE_NAME': '0', 04:32:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-zNQPdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-z2M6Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-iKCnMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-7CQP7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ak9j5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mKARkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:22 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Jv_gzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-206z9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_3cMml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_IHOO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-hBggEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-OY7tNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Ymey9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-QJpT79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ZvULsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:23 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-OriSS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:24 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-VlQO9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:24 INFO - Running setup.py install for manifestparser 04:32:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:24 INFO - Running setup.py install for mozcrash 04:32:24 INFO - Running setup.py install for mozdebug 04:32:24 INFO - Running setup.py install for mozdevice 04:32:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:24 INFO - Running setup.py install for mozfile 04:32:24 INFO - Running setup.py install for mozhttpd 04:32:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:24 INFO - Running setup.py install for mozinfo 04:32:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Running setup.py install for mozInstall 04:32:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Running setup.py install for mozleak 04:32:25 INFO - Running setup.py install for mozlog 04:32:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Running setup.py install for moznetwork 04:32:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Running setup.py install for mozprocess 04:32:25 INFO - Running setup.py install for mozprofile 04:32:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Running setup.py install for mozrunner 04:32:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Running setup.py install for mozscreenshot 04:32:26 INFO - Running setup.py install for moztest 04:32:26 INFO - Running setup.py install for mozversion 04:32:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:26 INFO - Cleaning up... 04:32:26 INFO - Return code: 0 04:32:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:26 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 0x105f10490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e86570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1bcc57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d24d30>, '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 0x105b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1cb20>, '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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 04:32:26 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 04:32:26 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 04:32:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmdmxHKoCf/Render', 04:32:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:26 INFO - 'HOME': '/Users/cltbld', 04:32:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:26 INFO - 'LOGNAME': 'cltbld', 04:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:26 INFO - 'MOZ_NO_REMOTE': '1', 04:32:26 INFO - 'NO_EM_RESTART': '1', 04:32:26 INFO - 'PAGER': '/bin/cat', 04:32:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:26 INFO - 'PWD': '/builds/slave/test', 04:32:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:26 INFO - 'SHELL': '/bin/bash', 04:32:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gN6uq8Nj9a/Listeners', 04:32:26 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 04:32:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:26 INFO - 'USER': 'cltbld', 04:32:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:26 INFO - 'XPC_FLAGS': '0x0', 04:32:26 INFO - 'XPC_SERVICE_NAME': '0', 04:32:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:26 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-7LI4Hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-BHJPhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ACzKOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-qiKpZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-8KThVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-TpwX2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-pY4zkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-dX2AuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-t4rvPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:27 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)) 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:27 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-DOEYKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-qxP27g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-iR9CDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-sxHGIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-e9i4Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-2IfuXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-eQRyvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:28 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)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:28 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_tqVof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:28 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)) 04:32:28 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)) 04:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:28 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)) 04:32:28 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)) 04:32:28 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)) 04:32:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:28 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 04:32:28 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 04:32:28 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 04:32:28 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 04:32:28 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 04:32:28 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 04:32:31 INFO - Downloading blessings-1.6.tar.gz 04:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:31 INFO - Installing collected packages: blessings 04:32:31 INFO - Running setup.py install for blessings 04:32:31 INFO - Successfully installed blessings 04:32:31 INFO - Cleaning up... 04:32:31 INFO - Return code: 0 04:32:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:31 INFO - Reading from file tmpfile_stdout 04:32:31 INFO - Current package versions: 04:32:31 INFO - blessings == 1.6 04:32:31 INFO - blobuploader == 1.2.4 04:32:31 INFO - docopt == 0.6.1 04:32:31 INFO - functools32 == 3.2.3-2 04:32:31 INFO - jsonschema == 2.5.1 04:32:31 INFO - manifestparser == 1.1 04:32:31 INFO - mozInstall == 1.12 04:32:31 INFO - mozcrash == 0.17 04:32:31 INFO - mozdebug == 0.1 04:32:31 INFO - mozdevice == 0.48 04:32:31 INFO - mozfile == 1.2 04:32:31 INFO - mozhttpd == 0.7 04:32:31 INFO - mozinfo == 0.9 04:32:31 INFO - mozleak == 0.1 04:32:31 INFO - mozlog == 3.4 04:32:31 INFO - moznetwork == 0.27 04:32:31 INFO - mozprocess == 0.23 04:32:31 INFO - mozprofile == 0.28 04:32:31 INFO - mozrunner == 6.12 04:32:31 INFO - mozscreenshot == 0.1 04:32:31 INFO - mozsystemmonitor == 0.3 04:32:31 INFO - moztest == 0.7 04:32:31 INFO - mozversion == 1.4 04:32:31 INFO - psutil == 3.1.1 04:32:31 INFO - requests == 1.2.3 04:32:31 INFO - wsgiref == 0.1.2 04:32:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 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 0x105f10490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e86570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1bcc57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d24d30>, '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 0x105b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1cb20>, '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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 04:32:32 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 04:32:32 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 04:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmdmxHKoCf/Render', 04:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:32 INFO - 'HOME': '/Users/cltbld', 04:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:32 INFO - 'LOGNAME': 'cltbld', 04:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:32 INFO - 'MOZ_NO_REMOTE': '1', 04:32:32 INFO - 'NO_EM_RESTART': '1', 04:32:32 INFO - 'PAGER': '/bin/cat', 04:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:32 INFO - 'PWD': '/builds/slave/test', 04:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:32 INFO - 'SHELL': '/bin/bash', 04:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gN6uq8Nj9a/Listeners', 04:32:32 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 04:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:32 INFO - 'USER': 'cltbld', 04:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:32 INFO - 'XPC_FLAGS': '0x0', 04:32:32 INFO - 'XPC_SERVICE_NAME': '0', 04:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32: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)) 04:32: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)) 04:32: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)) 04:32: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)) 04:32: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)) 04:32: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)) 04:32: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)) 04:32: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)) 04:32: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)) 04:32: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)) 04:32: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)) 04:32:33 INFO - Cleaning up... 04:32:33 INFO - Return code: 0 04:32:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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 0x105f10490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e86570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb1bcc57d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105d24d30>, '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 0x105b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1cb20>, '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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 04:32: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 04:32: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 04:32:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmdmxHKoCf/Render', 04:32:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:33 INFO - 'HOME': '/Users/cltbld', 04:32:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:33 INFO - 'LOGNAME': 'cltbld', 04:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:33 INFO - 'MOZ_NO_REMOTE': '1', 04:32:33 INFO - 'NO_EM_RESTART': '1', 04:32:33 INFO - 'PAGER': '/bin/cat', 04:32:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:33 INFO - 'PWD': '/builds/slave/test', 04:32:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:33 INFO - 'SHELL': '/bin/bash', 04:32:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gN6uq8Nj9a/Listeners', 04:32:33 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 04:32:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:33 INFO - 'USER': 'cltbld', 04:32:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:33 INFO - 'XPC_FLAGS': '0x0', 04:32:33 INFO - 'XPC_SERVICE_NAME': '0', 04:32:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:32:33 INFO - Cleaning up... 04:32:33 INFO - Return code: 0 04:32:33 INFO - Running post-action listener: _resource_record_post_action 04:32:33 INFO - Running post-action listener: _start_resource_monitoring 04:32:33 INFO - Starting resource monitoring. 04:32:33 INFO - [mozharness: 2016-10-17 11:32:33.691036Z] Finished create-virtualenv step (success) 04:32:33 INFO - [mozharness: 2016-10-17 11:32:33.692013Z] Running install step. 04:32:33 INFO - Running pre-action listener: _resource_record_pre_action 04:32:33 INFO - Running main action method: install 04:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:33 INFO - Reading from file tmpfile_stdout 04:32:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:34 INFO - Reading from file tmpfile_stdout 04:32:34 INFO - Output received: 04:32:34 INFO - Usage: mozinstall [options] installer 04:32:34 INFO - Options: 04:32:34 INFO - -h, --help show this help message and exit 04:32:34 INFO - -d DEST, --destination=DEST 04:32:34 INFO - Directory to install application into. [default: 04:32:34 INFO - "/builds/slave/test"] 04:32:34 INFO - --app=APP Application being installed. [default: firefox] 04:32:34 INFO - mkdir: /builds/slave/test/build/application 04:32:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:33:08 INFO - Reading from file tmpfile_stdout 04:33:08 INFO - Output received: 04:33:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:33:08 INFO - Running post-action listener: _resource_record_post_action 04:33:08 INFO - [mozharness: 2016-10-17 11:33:08.656532Z] Finished install step (success) 04:33:08 INFO - [mozharness: 2016-10-17 11:33:08.656667Z] Running run-tests step. 04:33:08 INFO - Running pre-action listener: _resource_record_pre_action 04:33:08 INFO - Running main action method: run_tests 04:33:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:08 INFO - 2016-10-17 04:33:08.671 screenresolution[2005:277556] starting screenresolution argv=screenresolution get 04:33:08 INFO - 2016-10-17 04:33:08.673 screenresolution[2005:277556] Display 0: 1600x1200x32@60 04:33:08 INFO - 2016-10-17 04:33:08.679 screenresolution[2006:277559] starting screenresolution argv=screenresolution list 04:33:08 INFO - Available Modes on Display 0 04:33:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:08 INFO - Intel Iris: 04:33:08 INFO - Chipset Model: Intel Iris 04:33:08 INFO - Type: GPU 04:33:08 INFO - Bus: Built-In 04:33:08 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:08 INFO - Vendor: Intel (0x8086) 04:33:08 INFO - Device ID: 0x0a2e 04:33:08 INFO - Revision ID: 0x0009 04:33:08 INFO - Displays: 04:33:08 INFO - Display: 04:33:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:08 INFO - Display Serial Number: 1600x1200 60 04:33:08 INFO - Main Display: Yes 04:33:08 INFO - Mirror: Off 04:33:08 INFO - Online: Yes 04:33:08 INFO - Rotation: Supported 04:33:08 INFO - Return code: 0 04:33:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:08 INFO - Python 2.7.3 04:33:08 INFO - Return code: 0 04:33:08 INFO - grabbing minidump binary from tooltool 04:33: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')]} 04:33: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 0x105d24d30>, '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 0x105b4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105d1cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33: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 04:33: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 04:33: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 04:33:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:09 INFO - Return code: 0 04:33:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:33:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mmdmxHKoCf/Render', 04:33:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:09 INFO - 'HOME': '/Users/cltbld', 04:33:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:09 INFO - 'LOGNAME': 'cltbld', 04:33:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:09 INFO - 'MOZ_NO_REMOTE': '1', 04:33:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:09 INFO - 'NO_EM_RESTART': '1', 04:33:09 INFO - 'PAGER': '/bin/cat', 04:33:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:09 INFO - 'PWD': '/builds/slave/test', 04:33:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:09 INFO - 'SHELL': '/bin/bash', 04:33:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gN6uq8Nj9a/Listeners', 04:33:09 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 04:33:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:09 INFO - 'USER': 'cltbld', 04:33:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:09 INFO - 'XPC_FLAGS': '0x0', 04:33:09 INFO - 'XPC_SERVICE_NAME': '0', 04:33:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:33:09 INFO - mozversion application_buildid: 20161017021835 04:33:09 INFO - mozversion application_changeset: 0191c2f3a6e8c0a241bc440cb61a8f15d061bc38 04:33:09 INFO - mozversion application_display_name: Nightly 04:33:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:09 INFO - mozversion application_name: Firefox 04:33:09 INFO - mozversion application_remotingname: firefox 04:33:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:33:09 INFO - mozversion application_vendor: Mozilla 04:33:09 INFO - mozversion application_version: 52.0a1 04:33:09 INFO - mozversion platform_buildid: 20161017021835 04:33:09 INFO - mozversion platform_changeset: 0191c2f3a6e8c0a241bc440cb61a8f15d061bc38 04:33:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:33:09 INFO - mozversion platform_version: 52.0a1 04:33:09 INFO - using testdate: 1476703989 04:33:09 INFO - actual date: 1476703989 04:33:09 INFO - starting webserver on 'localhost:49375' 04:33:09 INFO - SUITE-START | Running 2 tests 04:33:09 INFO - TEST-START | dromaeo_css 04:33:09 INFO - operating with platform_type : mac_ 04:33:09 INFO - Initialising browser for dromaeo_css test... 04:33:09 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpSlGdHs/profile http://localhost:49375/getInfo.html) 04:33:11 INFO - PROCESS | 2016 | __metrics Screen width/height:1600/1200 04:33:11 INFO - PROCESS | 2016 | colorDepth:24 04:33:11 INFO - PROCESS | 2016 | Browser inner width/height: 1024/689 04:33:11 INFO - PROCESS | 2016 | __metrics 04:33:11 INFO - PROCESS | 2016 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:33:11 INFO - PROCESS | 2016 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:12 INFO - TEST-INFO | 2016: exit 0 04:33:12 INFO - Browser initialized. 04:33:12 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:12 INFO - TEST-INFO | started process 2020 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpSlGdHs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:24 INFO - PROCESS | 2020 | RSS: Main: 230801408 04:33:24 INFO - PROCESS | 2020 | 04:34:15 INFO - PROCESS | 2020 | 1476704055920 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] 04:36:29 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49375/tests/dromaeo/cssquery-ext.html) 04:36:31 INFO - PROCESS | 2020 | RSS: Main: 406245376 04:36:31 INFO - PROCESS | 2020 | 04:39:34 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-ext.html (next: http://localhost:49375/tests/dromaeo/cssquery-jquery.html) 04:39:35 INFO - PROCESS | 2020 | RSS: Main: 372965376 04:39:35 INFO - PROCESS | 2020 | 04:42:37 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49375/tests/dromaeo/cssquery-mootools.html) 04:42:38 INFO - PROCESS | 2020 | RSS: Main: 359870464 04:42:38 INFO - PROCESS | 2020 | 04:45:40 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49375/tests/dromaeo/cssquery-prototype.html) 04:45:41 INFO - PROCESS | 2020 | RSS: Main: 336982016 04:45:41 INFO - PROCESS | 2020 | 04:48:44 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49375/tests/dromaeo/cssquery-yui.html) 04:48:45 INFO - PROCESS | 2020 | RSS: Main: 329748480 04:48:45 INFO - PROCESS | 2020 | 04:51:48 INFO - PROCESS | 2020 | Cycle 1(1): loaded http://localhost:49375/tests/dromaeo/cssquery-yui.html (next: http://localhost:49375/tests/dromaeo/cssquery-dojo.html) 04:51:48 INFO - PROCESS | 2020 | RSS: Main: 480026624 04:51:48 INFO - PROCESS | 2020 | 04:51:48 INFO - PROCESS | 2020 | __start_tp_report 04:51:48 INFO - PROCESS | 2020 | _x_x_mozilla_page_load 04:51:48 INFO - PROCESS | 2020 | _x_x_mozilla_page_load_details 04:51:48 INFO - PROCESS | 2020 | |i|pagename|runs| 04:51:48 INFO - PROCESS | 2020 | |0;dojo.html;3310.5861767279084;3311.7681762276634;3329.5505106810583;3353.480210567363;3385.2721664842056;5546.944530554693;5631.662100273987;5709.371969083398;5798.3331916829575;5799.188113664085;4660.347551342815;5618.606697531174;5631.267935168433;5799.217105690731;5819.418058194178;5078.695278283296;5144.305518754958;5191.299174611417;5210.218467229908;5226.660267082628;5264.552513036378;5290.709011004393;5301.469853014706;5312.973435132819;5377.274068000828;5271.578273738091;5302.125149350391;5323.920141197885;5332.706701131437;5370.892582148354;5117.897642047175;5167.940572182693;5183.974080129613;5190.8183213587345;5234.110201265794;5130.97434512825;5134.537891589737;5158.097332966716;5200.895982080375;5225.686458812484;5678.3186017678145;5713.514351280146;5717.1995920570735;5748.626339287933;5752.2234498342605;6037.486813620848;6107.26712794463;6136.877262454771;6230.5638605297645;6240.968795155995;6222.81331560054;6252.499800016033;6277.843053923642;6298.685065746694;6321.936780632181;5755.4244575542525;5791.449812267828;5806.854828629318;5809.9419005809405;5825.475707186373;6197.1324014637985;6210.378962103844;6268.655223962726;6273.498120150377;6342.651154186564;6044.425779550936;6054.8183554493435;6062.242219722535;6069.3627169147485;6074.997625391849;5175.922361164586;6176.722047507873;6178.073289006685;6180.6909654517995;6193.287771906198;6067.484263837623;6092.206638917683;6121.807818320517;6125.500987019177;6132.6933653317155;6138.081874382086;6140.3596453525415;6142.038385241494;6155.384461553809;6176.104464852571;4920.581750551171;4932.827351042696;4944.159492886218;4955.281484184773;4969.478204788517;4366.388705581221;4401.889952751143;4432.601065904084;4462.821487140478;4491.034427598082;5620.213170156181;5699.373068962411;5701.543876489871;5745.368009518949;5790.88418231633;6237.719302631393;6299.622022678563;6307.747690092437;6310;6323.272823625342;5812.534997200214;5817.941820581825;5819.301683797971;5833.649981001154;5871.794487193013;5269.077911365495;5347.171188465716;5411;5419.620626556103;5426.782928682887;6288.245410550763;6290.150829637941;6292.1505596743855;6298.842528936813;6304.369563043659;6084.452399284086;6160.476359509492;6169.043798211284;6169.290531588925;6179.412955769195;6121.087175196906;6248.156498872776;6280.685965701788;6285.402886725754;6310.432061114522;5484.7806087757635;5948.643081415129;6180.072989051499;6212.502999760099;6225.533085018732;6257.691849616911;6268.780592679234;6283.277423096402;6284.151639528788;6295.685215739286;5949.91075133882;5996.340402555803;6018.007028840368;6107.4922612924165;6123.9232566596775;6029.306629737636;6069.666168360783;6076.33160352352;6104.156010547632;6107.735039974651;5931.288245410578;5940.584159108821;5941.31674857397;5962.70186490665;6002.159697642246;5877.0302900021015;6111.388861113853;6113;6119.510439164945;6130.908036379547;5604.467575580314;5832.795852145155;5840.707964601668;5846.766129354778;5851.21008663842 04:51:48 INFO - PROCESS | 2020 | |1;ext.html;498.7954938475224;508.77613849906015;509.4065413792931;511.3327108123898;529.8834256463578;29528;39649.801750991275;39928.60071399285;39948.600513994854;42255.57744422562;42253.78873105638;42606;42672.14655706884;42681;42719.78640106803;9269.258459323271;9332.973372928973;9447.90552094477;9452.149306562407;9452.763680907963;9335.206507446876;9457.527123643791;9461.290403219786;9484.715458536255;9518.286128540352;9484.288678349118;9495.430274183536;9503;9503.097205765442;9524.333296669236;9418.434893906388;9441.575129119206;9471.242300615968;9473.763155921088;9478.052194780466;9317.39436936597;9390.812183756287;9414.717558473258;9419.152276295097;9420.717378478657;39576.01059973524;39925.60074399277;39948.20103597912;39953.601623943316;40051.399229011586;3163.9683603163903;3285.78642388244;3429.3998550253855;3527.0476971217886;3769.1142581493327;23213.187538436243;30877.691223087706;30984.60569274388;31498.685013149803;31530.527042094385;3173.428782819092;3179.72972297355;3217.8551965161623;3337.4660054391425;3351.447011243142;484755;485039;486453;486709.56645216903;504613.4769326167;30725.692743072283;31705;56571.43428565744;57036;57161.71419142878;33787.83106084454;34111.14722131967;34145.487817682755;34262;34293.14267143291;12252.632421027205;14886.032407893452;14896.925515372353;14909.403623855142;14927.029743066665;12614.05394595409;12699.428525716365;12707.872921270853;12708.173968692005;12730.108892377444;7696.461247712607;7703.614819259126;7800.375969922506;7800.765977020698;7809.297163255334;2523.6088406297054;3162.7153556180056;3207.342494788563;3212.9357412851614;3215.1640573450604;967.1247520993512;1012.4937531234383;1021.5300961557618;1050.375026859033;1069.9592561897348;29201;29614.851925740233;29642.85178574093;30466.84766576153;30537.69462305393;875.4790899414838;1025.9640912568025;1070.400575677623;1088.2327958789035;1130.5082289204222;14685.192314422595;15189.316480758393;15190.924045379703;15383.006483870022;15620.531384058497;612816;620032;622337.8883105646;623814;624822;57100.85798284011;57469.71265143647;57570;57602.71198644064;57673;1246.0529997202011;1279.117408987814;1287.2662582327982;1347.279205624986;1411.4636438153846;28999.13002609925;30208.395832083675;30890.0732978011;30993.8450307747;31648.841755791073;48655.75672121617;49192.754036231025;49211;49323;49385.50614493953;530592;531711;532826;533293;534087;25940.740592593833;26633.866830665724;27012;27273.454530908875;27524.311892202855;41725.53960611364;45461.545384547055;46457.76771116258;46599.76700116478;46863.765681171375;38693.613063869;38941.805290974495;39878.2024359517;40098;40964.79517602393;38194;38315.2336953265;38993;39629.00927476721;39780.403293951196;30361.696383035887;37002;37600.62399375971;38470.038249043995;38606.80696596499;26875.596866047417;31208.063758087294;33986.15034624154;34247;34341.14147146241;21429.678554822003;24668.87665561661;24907.252782416555;25176.49647007013;25722 04:51:48 INFO - PROCESS | 2020 | |2;jquery.html;331.4216691872682;331.68986997157646;336.4851776781524;345.33178299989504;376.3864900212653;15145.924270378646;15862.841371586295;16208;19965.80205187686;21261.149554017822;17910.910445447786;18387.72418413725;18550.81449185508;21276.787232127714;21483.46291342717;5651.1523271509295;5680.545556355502;5951.732172052247;5985.940140598604;6060.545459090586;5680.772769089232;6032.487238584704;6076.483498902577;6093.878122437549;6094.969525152368;5986.431289027535;6091.025435930252;6095.329513753483;6100.176476175704;6103.23709536308;5129.358830146231;5680.6591604503865;5891.64650120992;6032.155498230251;6113.969430152865;5855.151003104526;5860.443257890536;5861.88276234473;5863.384344643794;5876.11858221266;12927.418266178045;13224.008199385085;19232.903835480734;25545.45544662415;25657.74342256591;2009.6884982827685;2243.977560224393;2334.789868911789;2411.794997425221;2583.599542070982;9933.75165620858;10464.581416743322;10466.947665261625;11216.943915280453;14781.778273325908;1718.4844546636084;1769.513383819447;1784.4557409989948;1847.9630407391776;1868.588910439701;88862.11137888668;112751.43624281826;119131;122172;122886.38556807248;10933.890661093288;11066.28069175501;11117.27737697047;11664.533418663159;11721.765564688658;11278.605248816251;13084.934575327063;13626.591202263948;14322.427102915766;14471.421143154155;7350.96324518374;7377.88933166003;8661.870071948926;8670.566471676391;8801.47191168532;7237.118349229133;8218.602837517636;8668.306535477273;8808.339374546935;9003.099690030944;4547.613452856544;4565.954340456619;4573.49691533931;4599.149157405891;4641.767911604474;1897.9051047447572;1907.2085084689975;1944.2320283487943;1953.3651563242004;1961.0684924660957;841.995790021046;845.5307304446092;898.1018981018981;922.8892532896095;926.6756635177634;16043;20469.488262793548;20715.792842071387;21403;21640.891795541236;919.9954000229956;941.491594538955;979.8677178580942;993.2947607198826;1002.2683441088046;9126;9942.403455792532;10909.83635245456;11630.302181868945;11702.531898723955;582818;589123.0543847253;593741;608562;617704;135705.64294357126;138710;140140;142189;144240.27879860534;976.6093562575027;1001.1640280365831;1014.5586669798661;1017.3793985668736;1021.3514418344256;18781.436556903314;19525.414237572895;19750.209991600175;19766.90116549408;19812.405627831187;54773.45226547843;55028.72485637546;56474;57092.14361784494;57113.85772284448;82748.34503310021;83568;84827.5758621203;84862;84938.57530712307;7785;7819.296263336327;8005.279524842792;8017.358611311198;8159.428839981382;11262.986331230228;12601.306928119042;12604.55884044054;12672.74654506923;12859.678508037374;11006.779864402506;11191.552337906392;11286;11306.152038596974;11328.490217940047;10768.892311077103;10873.130149588173;10889.891101088888;10937.343759374464;11218.943905280421;11169.38568378747;11372;11404.828927565926;11424.600138995096;11447.427628618703;7282.781516554512;7921.702706215133;7923.841523169389;8043;8382.706605268786;8266.338692904674;11266.549338026387;11359.716007099889;11624.5350185995;11629.709257268636 04:51:48 INFO - PROCESS | 2020 | |3;mootools.html;1372.6156676130686;1531.4639876043386;1564.6948844975232;1770.601614636707;1917.1085445267947;7312.744053958112;7747.264009919063;7907.881381779278;8268.751937441886;8289.502629842214;8073;8117.107118216992;8213.383996200293;8218.95890520548;8220;2248.179414513707;2250.5723912456665;2256.684064231009;2258.695076164717;2280.2019293247313;2229.877356745378;2264.467850055236;2272.9545409091807;2279.894251288124;2285.737140228878;2236.7875051870046;2271.9091236350528;2278.2481781012225;2280.532490839374;2281.8288628352857;2231.2859884836857;2244.4052326133587;2260.886955652211;2262.162999690109;2262.7171603549555;2201.9779802202092;2202.108146200775;2208;2210.2706106984815;2215.601191785478;8145.185481451807;8219.83560328796;8229.135940726257;8232.670693172266;8233.259006689366;4897.559219670246;5121;5126.974605078962;5144.56271216947;5161.071007218699;2921.532554791223;3279.8688052477873;3400.4559270516597;3476.1309672581856;3490.2495963367996;991.8660980767648;1025.0364657222262;1030.7320096774818;1039.0907955538903;1047.8742550893942;8901.42140760855;10433.895661043369;10526.947365263124;10594.841077383846;10625.521851516778;4100.569440208795;4232.25935461293;4296.033392486665;4328.696991210585;4330.891727706832;8441.198086181803;8465.153484651486;8468.957655211685;8485.872711909326;8498;4942.678725882806;4955.5044495550155;4956.8760780980765;4961.875953101129;4967.006598680278;3896.123372241223;4164.271252530795;4326.459192600925;4329.328954012133;4559.338895860082;3347.7154441872226;3602.063463499509;3608.386574282378;3626.9818650907105;3631.473436351714;978.1832170138015;1075.956961721538;1103.2938919091628;1105.8341248812742;1113.154002957758;814.7840822182127;834.7245409015011;841.3059226138461;863.1282404771226;952.6808519146164;4705.764711764398;4896.2655601660035;5364.624476286701;5767.480926716616;5910.99513082777;895.4224525181222;911.7538264668635;917.3991035871514;960.9855852162223;983.488585935324;3799.2021675448464;3903.2974064668633;3928.8035598219976;4035.3543433050572;4039.111395492987;9617.326787124834;9904.950475247722;9968.501574921225;9970.800583988279;9985.151262142654;9870.358426702242;9948.154406875352;9948.900510994798;9949.80100397988;9959.850602240973;7528.811779705551;7635.770926872203;7646.694132234648;7796.220377962159;7804.102528209215;5323.64675757763;5720.199172115824;5723.456271654186;5783.710814459344;5813.505852002627;8823.60293786794;8979.236764875059;9114.498702571156;9206.217471514996;9309.534523273674;9085.500297483703;9427.670031548863;9502.952485237529;9541.141297283279;9541.47521886303;6573.868522629425;6745.392914637706;6791.89812152828;6941.861162776817;7181.784546463615;7911.446198766032;7946.006749156356;7972;7998.600069996361;7998.880016799636;6892.931070689229;7042.577445353295;7076.893846592202;7149.60677162761;7219.8556028880175;6777.661116944035;6853.211880633791;6882.655867206519;6986.266442023514;7073.717051318095;6359.904601431075;6539.215294164731;6627.039079333374;6632.734690612321;6726.293739157513;4826.444958829779;4840.975795121143;4854.320395144612;4882.633802464758;4986.825461108989;4293.7548111047445;4843.46721860588;4852.80588776445;4956.207006878882;5149.2276158576515 04:51:48 INFO - PROCESS | 2020 | |4;prototype.html;275.3762727422388;275.38588946648974;283.9829610223386;284.93873817129315;290.7339784097551;4340.565943405658;5150.3047088643025;5166.819161329354;5206.895862082756;5342.130254410954;4981.5516603505675;5027.824026159085;5166.276721259027;5169.689818610886;5180.171172612373;3373.1567108222944;3391.186115332327;3782.4893639358747;3786.4131059685724;3962.5443074046566;3077.307605788691;3736.4208547675153;3890.610938906115;4014.498187726534;4017.296973029708;3426.5202871597994;3569.607343192247;3583.390823560001;3917.1773927475265;4001.8199181036925;3221.3074189049466;3512.701420379271;3665.5521069177526;3858.9228215435814;3973.920521589581;3438.850718301062;3440.2626673529708;3441.328940856534;3450.879219227315;3456.4642480415578;4728.739919304437;5145.6398052136365;5166.741662916839;5189.870253243699;5211.791528338862;4015.859444919443;4212.978935105305;4476.709013914117;4480.686351955364;4504.346869703874;5304.363476382859;5486.451354864522;5516.531094856942;5537.916931246034;5548.140038294071;3684.9447258291148;3688.8155592220282;3692.372296709566;3700.1674623209833;3702.2965636528975;5420.891582168374;5793;5814.738336774855;5828.475437210672;5863.179154918314;3685.8341374638208;3728.9813550932613;3729.6083911188935;3735.234276973214;3746.550413950343;3781.810909454516;3807.7715337079308;3807.8667246646232;3809.561900381492;3816.37029890065;3539.292141571696;4117.890992300794;4497.707649002804;4501.572350626685;4502.311633137573;5609.382967873531;5621.831345059655;5628.521575666115;5637.295338082739;5647.837211161763;1208.6313674329415;1224.1797995342963;1283.813846992181;1310.2662508994993;1311.9409626566828;674.5750177388214;701.4947461891352;778.6807408962298;796.6972550430916;806.3670019035146;3897.4738410314244;4427.335899615019;4435.602785122676;4475.149721552894;4528.366028755977;4050.205358302762;4482.7810233934415;4674.462436819741;4824.324594556765;4869.488703686062;3987.601239876047;4215.704900656986;4432.84485043022;4706.493921944944;5022.949770502321;2411.493586346887;2550.7066687330826;2562.5003124390937;2857.399946011361;3024.5311976643657;5317.341329335332;5993.220881285492;6001.789042862048;6015.488683461867;6034.5172386209;5043.621728370314;5362.946370536322;5861.677607731615;5883.734996975585;5912.645241285537;4823.662343635911;5970.432713933051;5998.760049597967;6010.797840431844;6020.969895150496;4342.609165175149;5008.69947803133;5323.9884421959705;5685.175649530877;5689.91891540606;5538.864532770853;5635.464630860061;5656.43435656431;5659.688717120598;5677.68772717488;4934.679245849008;5233.764480598458;5924.940750592439;5950;5977.462028417463;3135.980806237936;3286.0470463566253;3535.505029295849;3683.3001729671278;3701.3707669695677;4783.736894470699;5231.39838918514;5694.515966142924;5726.79956201531;5882.94107060716;4300.0109974705365;4722.456917454537;5276.551493123127;5352.0366334060245;5474.343078830566;5210.426853046238;5525.917111243254;5535.750891209825;5590.580706447114;5671.886562268649;4840.370751802243;5549.556035517229;5556.388797232382;5556.972215138899;5576.302962129734;5004.4495105537635;5174.275601415729;5498.642588231752;5666.546676265972;5670.914936275876;4984.551390374883;5233.319668443078;5511.476409741068;5527.944720552904;5538.446155384429 04:51:48 INFO - PROCESS | 2020 | |5;yui.html;706.9964650176752;719.6186021408652;769.0463824857179;804.1114568401912;825.8513467575835;15408.152551609672;15804.051756894594;15827.683446331066;15831.604209894758;15845.762313565307;14115.717685646281;14220.928895355508;14243.287835608204;14246.928765356184;14247.430102795875;701.6526819224491;731.0532859946355;731.4806487393956;876.9693060742875;882.2412725056462;891.2112780189547;896.7847716548047;907.4645958884257;911.1207684584375;911.5670056723037;964.9131578158;968.7771812483134;970.3886551472598;970.6311601591385;972.7568107973007;732.2860211294;761.8628646843566;957.0955447102491;958.8513780364054;959.2997112108166;686.8488932434906;715.3168723868692;716.6452605960083;717.2612209424301;719.0472623773521;14915;14981.850181498154;15002.549923502313;15010.924945375204;15028.549143525712;13353.73292534144;13656.385462654105;13742.381592828247;13802.17186968775;13894.722105557934;12030.4586293617;12166.209196402206;12250.081243906743;12285.69285767854;12599.93700031503;4407.427034485497;4413.624841888443;4503.121891231179;4609.009063051427;4617.699849509771;109789;110785.89214107917;116364.89067077228;119852.40073799662;124803;10928.890711092947;10970.286931349438;11000.394978276112;11029.393383363831;11133.276337038067;21340.253091141734;21498.247561335593;21537.353879383645;21586.6761998567;21833.67249491259;7708.576028318496;7808.804779880548;7810.297073263434;7837.686492540349;7894.921050789419;4270.10327831159;4306.569343065668;4319.092990472036;4365.454318210223;4482.439695038121;3328.151321413024;3489.94765078524;3490.075130090528;3499.7900125992523;3501.474778783203;628.6102616377875;632.822809613309;639.3542522052667;640.897456406982;645.5481163185789;603.2338929559435;614.4224429036781;643.6009674002148;649.9772507962199;656.2223764838682;8210.261076503024;8775.868361974575;8890.110988901188;9118.800152657393;9123.406978546373;499.4442312197551;584.964902105875;605.9000264956233;636.8248731598848;641.352382554816;4120.793960301973;4263.978680106642;4360.978195109004;4403.097365040159;4484.820607175677;93472.13055738847;97922;106042.46978765057;146657;167681;131554;141581;143399;143452.28273858564;146344.26827865792;92675.53662231646;97270.54094188593;110810.44594777135;117901.41049294699;119213;9494.857577136487;9626.855597166188;9883.159931405911;10060;10102.545385457524;43127.9218019552;45995;56997.715011426335;60657.69671151793;61519;61178.38821611905;62372.752544949755;81589.77615335894;88521;96161.51919240359;12562.43469043877;13279.203247805162;13323;13734.793978090536;13959.092658977133;14506.690633113725;14683.48607798722;14702.926485367932;15366.385344586539;15510.84489155139;13607.183568985893;13683.657908552366;13761;14140.858591414366;14489;12158.661548981481;12168.391580420766;13294.601161965156;13700.97242706781;13968.485672579034;13179.802302965272;13280.867191327963;13296;13783.586492405244;13951.302434878013;10625.565548651142;11129.833052504056;11206.271592346471;11610.419479025846;11634.60384753835;10634.574617015232;10846.566137354734;11371.545138194711;11557.653270401901;11638.88361116412 04:51:48 INFO - PROCESS | 2020 | __end_tp_report 04:51:48 INFO - PROCESS | 2020 | __start_cc_report 04:51:48 INFO - PROCESS | 2020 | _x_x_mozilla_cycle_collect,1807 04:51:48 INFO - PROCESS | 2020 | __end_cc_report 04:51:48 INFO - PROCESS | 2020 | __startTimestamp1476705108680__endTimestamp 04:51:48 INFO - PROCESS | 2020 | 04:51:48 INFO - PROCESS | 2020 | ------- Summary: start ------- 04:51:48 INFO - PROCESS | 2020 | Number of tests: 6 04:51:48 INFO - PROCESS | 2020 | 04:51:48 INFO - PROCESS | 2020 | [#0] dojo.html Cycles:165 Average:5718.32 Median:5877.03 stddev:631.62 (10.7%) stddev-sans-first:604.66 04:51:48 INFO - PROCESS | 2020 | Values: 3310.6 3311.8 3329.6 3353.5 3385.3 5546.9 5631.7 5709.4 5798.3 5799.2 4660.3 5618.6 5631.3 5799.2 5819.4 5078.7 5144.3 5191.3 5210.2 5226.7 5264.6 5290.7 5301.5 5313.0 5377.3 5271.6 5302.1 5323.9 5332.7 5370.9 5117.9 5167.9 5184.0 5190.8 5234.1 5131.0 5134.5 5158.1 5200.9 5225.7 5678.3 5713.5 5717.2 5748.6 5752.2 6037.5 6107.3 6136.9 6230.6 6241.0 6222.8 6252.5 6277.8 6298.7 6321.9 5755.4 5791.4 5806.9 5809.9 5825.5 6197.1 6210.4 6268.7 6273.5 6342.7 6044.4 6054.8 6062.2 6069.4 6075.0 5175.9 6176.7 6178.1 6180.7 6193.3 6067.5 6092.2 6121.8 6125.5 6132.7 6138.1 6140.4 6142.0 6155.4 6176.1 4920.6 4932.8 4944.2 4955.3 4969.5 4366.4 4401.9 4432.6 4462.8 4491.0 5620.2 5699.4 5701.5 5745.4 5790.9 6237.7 6299.6 6307.7 6310.0 6323.3 5812.5 5817.9 5819.3 5833.6 5871.8 5269.1 5347.2 5411.0 5419.6 5426.8 6288.2 6290.2 6292.2 6298.8 6304.4 6084.5 6160.5 6169.0 6169.3 6179.4 6121.1 6248.2 6280.7 6285.4 6310.4 5484.8 5948.6 6180.1 6212.5 6225.5 6257.7 6268.8 6283.3 6284.2 6295.7 5949.9 5996.3 6018.0 6107.5 6123.9 6029.3 6069.7 6076.3 6104.2 6107.7 5931.3 5940.6 5941.3 5962.7 6002.2 5877.0 6111.4 6113.0 6119.5 6130.9 5604.5 5832.8 5840.7 5846.8 5851.2 04:51:48 INFO - PROCESS | 2020 | 04:51:48 INFO - PROCESS | 2020 | [#1] ext.html Cycles:180 Average:66549.18 Median:39284.51 stddev:147227.33 (374.8%) stddev-sans-first:147556.82 04:51:48 INFO - PROCESS | 2020 | Values: 498.8 508.8 509.4 511.3 529.9 29528.0 39649.8 39928.6 39948.6 42255.6 42253.8 42606.0 42672.1 42681.0 42719.8 9269.3 9333.0 9447.9 9452.1 9452.8 9335.2 9457.5 9461.3 9484.7 9518.3 9484.3 9495.4 9503.0 9503.1 9524.3 9418.4 9441.6 9471.2 9473.8 9478.1 9317.4 9390.8 9414.7 9419.2 9420.7 39576.0 39925.6 39948.2 39953.6 40051.4 3164.0 3285.8 3429.4 3527.0 3769.1 23213.2 30877.7 30984.6 31498.7 31530.5 3173.4 3179.7 3217.9 3337.5 3351.4 484755.0 485039.0 486453.0 486709.6 504613.5 30725.7 31705.0 56571.4 57036.0 57161.7 33787.8 34111.1 34145.5 34262.0 34293.1 12252.6 14886.0 14896.9 14909.4 14927.0 12614.1 12699.4 12707.9 12708.2 12730.1 7696.5 7703.6 7800.4 7800.8 7809.3 2523.6 3162.7 3207.3 3212.9 3215.2 967.1 1012.5 1021.5 1050.4 1070.0 29201.0 29614.9 29642.9 30466.8 30537.7 875.5 1026.0 1070.4 1088.2 1130.5 14685.2 15189.3 15190.9 15383.0 15620.5 612816.0 620032.0 622337.9 623814.0 624822.0 57100.9 57469.7 57570.0 57602.7 57673.0 1246.1 1279.1 1287.3 1347.3 1411.5 28999.1 30208.4 30890.1 30993.8 31648.8 48655.8 49192.8 49211.0 49323.0 49385.5 530592.0 531711.0 532826.0 533293.0 534087.0 25940.7 26633.9 27012.0 27273.5 27524.3 41725.5 45461.5 46457.8 46599.8 46863.8 38693.6 38941.8 39878.2 40098.0 40964.8 38194.0 38315.2 38993.0 39629.0 39780.4 30361.7 37002.0 37600.6 38470.0 38606.8 26875.6 31208.1 33986.2 34247.0 34341.1 21429.7 24668.9 24907.3 25176.5 25722.0 04:51:48 INFO - PROCESS | 2020 | 04:51:48 INFO - PROCESS | 2020 | [#2] jquery.html Cycles:180 Average:35206.25 Median:2373.29 stddev:100286.26 (4225.6%) stddev-sans-first:100533.40 04:51:48 INFO - PROCESS | 2020 | Values: 331.4 331.7 336.5 345.3 376.4 15145.9 15862.8 16208.0 19965.8 21261.1 17910.9 18387.7 18550.8 21276.8 21483.5 5651.2 5680.5 5951.7 5985.9 6060.5 5680.8 6032.5 6076.5 6093.9 6095.0 5986.4 6091.0 6095.3 6100.2 6103.2 5129.4 5680.7 5891.6 6032.2 6114.0 5855.2 5860.4 5861.9 5863.4 5876.1 12927.4 13224.0 19232.9 25545.5 25657.7 2009.7 2244.0 2334.8 2411.8 2583.6 9933.8 10464.6 10466.9 11216.9 14781.8 1718.5 1769.5 1784.5 1848.0 1868.6 88862.1 112751.4 119131.0 122172.0 122886.4 10933.9 11066.3 11117.3 11664.5 11721.8 11278.6 13084.9 13626.6 14322.4 14471.4 7351.0 7377.9 8661.9 8670.6 8801.5 7237.1 8218.6 8668.3 8808.3 9003.1 4547.6 4566.0 4573.5 4599.1 4641.8 1897.9 1907.2 1944.2 1953.4 1961.1 842.0 845.5 898.1 922.9 926.7 16043.0 20469.5 20715.8 21403.0 21640.9 920.0 941.5 979.9 993.3 1002.3 9126.0 9942.4 10909.8 11630.3 11702.5 582818.0 589123.1 593741.0 608562.0 617704.0 135705.6 138710.0 140140.0 142189.0 144240.3 976.6 1001.2 1014.6 1017.4 1021.4 18781.4 19525.4 19750.2 19766.9 19812.4 54773.5 55028.7 56474.0 57092.1 57113.9 82748.3 83568.0 84827.6 84862.0 84938.6 7785.0 7819.3 8005.3 8017.4 8159.4 11263.0 12601.3 12604.6 12672.7 12859.7 11006.8 11191.6 11286.0 11306.2 11328.5 10768.9 10873.1 10889.9 10937.3 11218.9 11169.4 11372.0 11404.8 11424.6 11447.4 7282.8 7921.7 7923.8 8043.0 8382.7 8266.3 11266.5 11359.7 11624.5 11629.7 04:51:48 INFO - PROCESS | 2020 | 04:51:48 INFO - PROCESS | 2020 | [#3] mootools.html Cycles:180 Average:5311.92 Median:5542.41 stddev:2904.04 (52.4%) stddev-sans-first:2897.09 04:51:48 INFO - PROCESS | 2020 | Values: 1372.6 1531.5 1564.7 1770.6 1917.1 7312.7 7747.3 7907.9 8268.8 8289.5 8073.0 8117.1 8213.4 8219.0 8220.0 2248.2 2250.6 2256.7 2258.7 2280.2 2229.9 2264.5 2273.0 2279.9 2285.7 2236.8 2271.9 2278.2 2280.5 2281.8 2231.3 2244.4 2260.9 2262.2 2262.7 2202.0 2202.1 2208.0 2210.3 2215.6 8145.2 8219.8 8229.1 8232.7 8233.3 4897.6 5121.0 5127.0 5144.6 5161.1 2921.5 3279.9 3400.5 3476.1 3490.2 991.9 1025.0 1030.7 1039.1 1047.9 8901.4 10433.9 10526.9 10594.8 10625.5 4100.6 4232.3 4296.0 4328.7 4330.9 8441.2 8465.2 8469.0 8485.9 8498.0 4942.7 4955.5 4956.9 4961.9 4967.0 3896.1 4164.3 4326.5 4329.3 4559.3 3347.7 3602.1 3608.4 3627.0 3631.5 978.2 1076.0 1103.3 1105.8 1113.2 814.8 834.7 841.3 863.1 952.7 4705.8 4896.3 5364.6 5767.5 5911.0 895.4 911.8 917.4 961.0 983.5 3799.2 3903.3 3928.8 4035.4 4039.1 9617.3 9905.0 9968.5 9970.8 9985.2 9870.4 9948.2 9948.9 9949.8 9959.9 7528.8 7635.8 7646.7 7796.2 7804.1 5323.6 5720.2 5723.5 5783.7 5813.5 8823.6 8979.2 9114.5 9206.2 9309.5 9085.5 9427.7 9503.0 9541.1 9541.5 6573.9 6745.4 6791.9 6941.9 7181.8 7911.4 7946.0 7972.0 7998.6 7998.9 6892.9 7042.6 7076.9 7149.6 7219.9 6777.7 6853.2 6882.7 6986.3 7073.7 6359.9 6539.2 6627.0 6632.7 6726.3 4826.4 4841.0 4854.3 4882.6 4986.8 4293.8 4843.5 4852.8 4956.2 5149.2 04:51:48 INFO - PROCESS | 2020 | 04:51:48 INFO - PROCESS | 2020 | [#4] prototype.html Cycles:180 Average:4383.55 Median:4854.93 stddev:1412.51 (29.1%) stddev-sans-first:1382.40 04:51:48 INFO - PROCESS | 2020 | Values: 275.4 275.4 284.0 284.9 290.7 4340.6 5150.3 5166.8 5206.9 5342.1 4981.6 5027.8 5166.3 5169.7 5180.2 3373.2 3391.2 3782.5 3786.4 3962.5 3077.3 3736.4 3890.6 4014.5 4017.3 3426.5 3569.6 3583.4 3917.2 4001.8 3221.3 3512.7 3665.6 3858.9 3973.9 3438.9 3440.3 3441.3 3450.9 3456.5 4728.7 5145.6 5166.7 5189.9 5211.8 4015.9 4213.0 4476.7 4480.7 4504.3 5304.4 5486.5 5516.5 5537.9 5548.1 3684.9 3688.8 3692.4 3700.2 3702.3 5420.9 5793.0 5814.7 5828.5 5863.2 3685.8 3729.0 3729.6 3735.2 3746.6 3781.8 3807.8 3807.9 3809.6 3816.4 3539.3 4117.9 4497.7 4501.6 4502.3 5609.4 5621.8 5628.5 5637.3 5647.8 1208.6 1224.2 1283.8 1310.3 1311.9 674.6 701.5 778.7 796.7 806.4 3897.5 4427.3 4435.6 4475.1 4528.4 4050.2 4482.8 4674.5 4824.3 4869.5 3987.6 4215.7 4432.8 4706.5 5022.9 2411.5 2550.7 2562.5 2857.4 3024.5 5317.3 5993.2 6001.8 6015.5 6034.5 5043.6 5362.9 5861.7 5883.7 5912.6 4823.7 5970.4 5998.8 6010.8 6021.0 4342.6 5008.7 5324.0 5685.2 5689.9 5538.9 5635.5 5656.4 5659.7 5677.7 4934.7 5233.8 5924.9 5950.0 5977.5 3136.0 3286.0 3535.5 3683.3 3701.4 4783.7 5231.4 5694.5 5726.8 5882.9 4300.0 4722.5 5276.6 5352.0 5474.3 5210.4 5525.9 5535.8 5590.6 5671.9 4840.4 5549.6 5556.4 5557.0 5576.3 5004.4 5174.3 5498.6 5666.5 5670.9 4984.6 5233.3 5511.5 5527.9 5538.4 04:51:48 INFO - PROCESS | 2020 | 04:51:48 INFO - PROCESS | 2020 | [#5] yui.html Cycles:180 Average:23996.43 Median:3494.93 stddev:38355.26 (1097.5%) stddev-sans-first:38423.00 04:51:48 INFO - PROCESS | 2020 | Values: 707.0 719.6 769.0 804.1 825.9 15408.2 15804.1 15827.7 15831.6 15845.8 14115.7 14220.9 14243.3 14246.9 14247.4 701.7 731.1 731.5 877.0 882.2 891.2 896.8 907.5 911.1 911.6 964.9 968.8 970.4 970.6 972.8 732.3 761.9 957.1 958.9 959.3 686.8 715.3 716.6 717.3 719.0 14915.0 14981.9 15002.5 15010.9 15028.5 13353.7 13656.4 13742.4 13802.2 13894.7 12030.5 12166.2 12250.1 12285.7 12599.9 4407.4 4413.6 4503.1 4609.0 4617.7 109789.0 110785.9 116364.9 119852.4 124803.0 10928.9 10970.3 11000.4 11029.4 11133.3 21340.3 21498.2 21537.4 21586.7 21833.7 7708.6 7808.8 7810.3 7837.7 7894.9 4270.1 4306.6 4319.1 4365.5 4482.4 3328.2 3489.9 3490.1 3499.8 3501.5 628.6 632.8 639.4 640.9 645.5 603.2 614.4 643.6 650.0 656.2 8210.3 8775.9 8890.1 9118.8 9123.4 499.4 585.0 605.9 636.8 641.4 4120.8 4264.0 4361.0 4403.1 4484.8 93472.1 97922.0 106042.5 146657.0 167681.0 131554.0 141581.0 143399.0 143452.3 146344.3 92675.5 97270.5 110810.4 117901.4 119213.0 9494.9 9626.9 9883.2 10060.0 10102.5 43127.9 45995.0 56997.7 60657.7 61519.0 61178.4 62372.8 81589.8 88521.0 96161.5 12562.4 13279.2 13323.0 13734.8 13959.1 14506.7 14683.5 14702.9 15366.4 15510.8 13607.2 13683.7 13761.0 14140.9 14489.0 12158.7 12168.4 13294.6 13701.0 13968.5 13179.8 13280.9 13296.0 13783.6 13951.3 10625.6 11129.8 11206.3 11610.4 11634.6 10634.6 10846.6 11371.5 11557.7 11638.9 04:51:48 INFO - PROCESS | 2020 | -------- Summary: end -------- 04:51:48 INFO - PROCESS | 2020 | 04:51:49 INFO - TEST-INFO | 2020: exit 0 04:51:49 INFO - TEST-OK | dromaeo_css | took 1120071ms 04:51:49 INFO - TEST-START | kraken 04:51:49 INFO - operating with platform_type : mac_ 04:51:49 INFO - Initialising browser for kraken test... 04:51:49 INFO - TEST-INFO | started process 2024 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp7sDGWy/profile http://localhost:49375/getInfo.html) 04:51:51 INFO - PROCESS | 2024 | __metrics Screen width/height:1600/1200 04:51:51 INFO - PROCESS | 2024 | colorDepth:24 04:51:51 INFO - PROCESS | 2024 | Browser inner width/height: 1024/689 04:51:51 INFO - PROCESS | 2024 | __metrics 04:51:51 INFO - PROCESS | 2024 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:51:51 INFO - PROCESS | 2024 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:51:52 INFO - TEST-INFO | 2024: exit 0 04:51:52 INFO - Browser initialized. 04:51:52 INFO - Running cycle 1/1 for kraken test... 04:51:52 INFO - TEST-INFO | started process 2025 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp7sDGWy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:04 INFO - PROCESS | 2025 | RSS: Main: 232341504 04:52:04 INFO - PROCESS | 2025 | 04:52:07 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:08 INFO - PROCESS | 2025 | RSS: Main: 290807808 04:52:08 INFO - PROCESS | 2025 | 04:52:10 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-dft) 04:52:11 INFO - PROCESS | 2025 | RSS: Main: 292175872 04:52:11 INFO - PROCESS | 2025 | 04:52:15 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-fft) 04:52:15 INFO - PROCESS | 2025 | RSS: Main: 383410176 04:52:15 INFO - PROCESS | 2025 | 04:52:17 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49375/tests/kraken/driver.html?testName=audio-oscillator) 04:52:18 INFO - PROCESS | 2025 | RSS: Main: 289296384 04:52:18 INFO - PROCESS | 2025 | 04:52:20 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:20 INFO - PROCESS | 2025 | RSS: Main: 290516992 04:52:20 INFO - PROCESS | 2025 | 04:52:23 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:24 INFO - PROCESS | 2025 | RSS: Main: 327819264 04:52:24 INFO - PROCESS | 2025 | 04:52:27 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49375/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:27 INFO - PROCESS | 2025 | RSS: Main: 329383936 04:52:27 INFO - PROCESS | 2025 | 04:52:30 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49375/tests/kraken/driver.html?testName=json-parse-financial) 04:52:31 INFO - PROCESS | 2025 | RSS: Main: 326729728 04:52:31 INFO - PROCESS | 2025 | 04:52:32 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49375/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:33 INFO - PROCESS | 2025 | RSS: Main: 303263744 04:52:33 INFO - PROCESS | 2025 | 04:52:35 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:35 INFO - PROCESS | 2025 | RSS: Main: 304775168 04:52:35 INFO - PROCESS | 2025 | 04:52:37 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:38 INFO - PROCESS | 2025 | RSS: Main: 308326400 04:52:38 INFO - PROCESS | 2025 | 04:52:41 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:42 INFO - PROCESS | 2025 | RSS: Main: 321634304 04:52:42 INFO - PROCESS | 2025 | 04:52:45 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:45 INFO - PROCESS | 2025 | RSS: Main: 315281408 04:52:45 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | Cycle 1(1): loaded http://localhost:49375/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49375/tests/kraken/driver.html?testName=ai-astar) 04:52:47 INFO - PROCESS | 2025 | RSS: Main: 359342080 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | __start_tp_report 04:52:47 INFO - PROCESS | 2025 | _x_x_mozilla_page_load 04:52:47 INFO - PROCESS | 2025 | _x_x_mozilla_page_load_details 04:52:47 INFO - PROCESS | 2025 | |i|pagename|runs| 04:52:47 INFO - PROCESS | 2025 | |0;ai-astar;103;116;115;114;115;116;114;115;113;114 04:52:47 INFO - PROCESS | 2025 | |1;audio-beat-detection;150;115;114;150;115;113;115;113;144;114 04:52:47 INFO - PROCESS | 2025 | |2;audio-dft;184;182;185;186;184;185;179;183;181;185 04:52:47 INFO - PROCESS | 2025 | |3;audio-fft;80;59;59;89;63;59;59;58;86;58 04:52:47 INFO - PROCESS | 2025 | |4;audio-oscillator;85;71;96;70;69;70;94;67;68;91 04:52:47 INFO - PROCESS | 2025 | |5;imaging-gaussian-blur;87;85;88;85;87;84;88;85;87;84 04:52:47 INFO - PROCESS | 2025 | |6;imaging-darkroom;94;103;93;94;94;93;93;94;94;94 04:52:47 INFO - PROCESS | 2025 | |7;imaging-desaturate;85;81;78;81;81;81;86;83;81;84 04:52:47 INFO - PROCESS | 2025 | |8;json-parse-financial;46;60;54;56;56;57;57;56;57;56 04:52:47 INFO - PROCESS | 2025 | |9;json-stringify-tinderbox;63;73;64;79;71;69;67;69;69;71 04:52:47 INFO - PROCESS | 2025 | |10;stanford-crypto-aes;77;87;93;106;89;86;87;93;87;91 04:52:47 INFO - PROCESS | 2025 | |11;stanford-crypto-ccm;148;146;145;145;144;146;147;146;191;147 04:52:47 INFO - PROCESS | 2025 | |12;stanford-crypto-pbkdf2;174;174;171;172;172;172;171;172;171;171 04:52:47 INFO - PROCESS | 2025 | |13;stanford-crypto-sha256-iterative;68;70;69;67;69;70;69;69;70;75 04:52:47 INFO - PROCESS | 2025 | __end_tp_report 04:52:47 INFO - PROCESS | 2025 | __start_cc_report 04:52:47 INFO - PROCESS | 2025 | _x_x_mozilla_cycle_collect,1999 04:52:47 INFO - PROCESS | 2025 | __end_cc_report 04:52:47 INFO - PROCESS | 2025 | __startTimestamp1476705167837__endTimestamp 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | ------- Summary: start ------- 04:52:47 INFO - PROCESS | 2025 | Number of tests: 14 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.81 (3.3%) stddev-sans-first:1.00 04:52:47 INFO - PROCESS | 2025 | Values: 103.0 116.0 115.0 114.0 115.0 116.0 114.0 115.0 113.0 114.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:115.00 stddev:16.45 (14.3%) stddev-sans-first:14.59 04:52:47 INFO - PROCESS | 2025 | Values: 150.0 115.0 114.0 150.0 115.0 113.0 115.0 113.0 144.0 114.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.50 stddev:2.17 (1.2%) stddev-sans-first:2.29 04:52:47 INFO - PROCESS | 2025 | Values: 184.0 182.0 185.0 186.0 184.0 185.0 179.0 183.0 181.0 185.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#3] audio-fft Cycles:10 Average:67.00 Median:61.00 stddev:12.68 (20.8%) stddev-sans-first:12.55 04:52:47 INFO - PROCESS | 2025 | Values: 80.0 59.0 59.0 89.0 63.0 59.0 59.0 58.0 86.0 58.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:78.00 stddev:11.91 (15.3%) stddev-sans-first:12.37 04:52:47 INFO - PROCESS | 2025 | Values: 85.0 71.0 96.0 70.0 69.0 70.0 94.0 67.0 68.0 91.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 04:52:47 INFO - PROCESS | 2025 | Values: 87.0 85.0 88.0 85.0 87.0 84.0 88.0 85.0 87.0 84.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:94.00 stddev:2.99 (3.2%) stddev-sans-first:3.16 04:52:47 INFO - PROCESS | 2025 | Values: 94.0 103.0 93.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#7] imaging-desaturate Cycles:10 Average:82.10 Median:82.00 stddev:2.38 (2.9%) stddev-sans-first:2.28 04:52:47 INFO - PROCESS | 2025 | Values: 85.0 81.0 78.0 81.0 81.0 81.0 86.0 83.0 81.0 84.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.50 stddev:3.66 (6.5%) stddev-sans-first:1.59 04:52:47 INFO - PROCESS | 2025 | Values: 46.0 60.0 54.0 56.0 56.0 57.0 57.0 56.0 57.0 56.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:4.55 (6.5%) stddev-sans-first:4.18 04:52:47 INFO - PROCESS | 2025 | Values: 63.0 73.0 64.0 79.0 71.0 69.0 67.0 69.0 69.0 71.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:88.00 stddev:7.35 (8.4%) stddev-sans-first:6.22 04:52:47 INFO - PROCESS | 2025 | Values: 77.0 87.0 93.0 106.0 89.0 86.0 87.0 93.0 87.0 91.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:146.50 stddev:14.28 (9.7%) stddev-sans-first:15.11 04:52:47 INFO - PROCESS | 2025 | Values: 148.0 146.0 145.0 145.0 144.0 146.0 147.0 146.0 191.0 147.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:172.00 stddev:1.15 (0.7%) stddev-sans-first:0.97 04:52:47 INFO - PROCESS | 2025 | Values: 174.0 174.0 171.0 172.0 172.0 172.0 171.0 172.0 171.0 171.0 04:52:47 INFO - PROCESS | 2025 | 04:52:47 INFO - PROCESS | 2025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:2.12 (3.0%) stddev-sans-first:2.17 04:52:47 INFO - PROCESS | 2025 | Values: 68.0 70.0 69.0 67.0 69.0 70.0 69.0 69.0 70.0 75.0 04:52:47 INFO - PROCESS | 2025 | -------- Summary: end -------- 04:52:47 INFO - PROCESS | 2025 | 04:52:48 INFO - TEST-INFO | 2025: exit 0 04:52:48 INFO - TEST-OK | kraken | took 59443ms 04:52:48 INFO - SUITE-END | took 1179s 04:52:48 INFO - Completed test suite (00:19:39) 04:52:48 INFO - javascript benchmark 04:52:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.5861767279084, 3311.7681762276634, 3329.5505106810583, 3353.480210567363, 3385.2721664842056, 5546.944530554693, 5631.662100273987, 5709.371969083398, 5798.3331916829575, 5799.188113664085, 4660.347551342815, 5618.606697531174, 5631.267935168433, 5799.217105690731, 5819.418058194178, 5078.695278283296, 5144.305518754958, 5191.299174611417, 5210.218467229908, 5226.660267082628, 5264.552513036378, 5290.709011004393, 5301.469853014706, 5312.973435132819, 5377.274068000828, 5271.578273738091, 5302.125149350391, 5323.920141197885, 5332.706701131437, 5370.892582148354, 5117.897642047175, 5167.940572182693, 5183.974080129613, 5190.8183213587345, 5234.110201265794, 5130.97434512825, 5134.537891589737, 5158.097332966716, 5200.895982080375, 5225.686458812484, 5678.3186017678145, 5713.514351280146, 5717.1995920570735, 5748.626339287933, 5752.2234498342605, 6037.486813620848, 6107.26712794463, 6136.877262454771, 6230.5638605297645, 6240.968795155995, 6222.81331560054, 6252.499800016033, 6277.843053923642, 6298.685065746694, 6321.936780632181, 5755.4244575542525, 5791.449812267828, 5806.854828629318, 5809.9419005809405, 5825.475707186373, 6197.1324014637985, 6210.378962103844, 6268.655223962726, 6273.498120150377, 6342.651154186564, 6044.425779550936, 6054.8183554493435, 6062.242219722535, 6069.3627169147485, 6074.997625391849, 5175.922361164586, 6176.722047507873, 6178.073289006685, 6180.6909654517995, 6193.287771906198, 6067.484263837623, 6092.206638917683, 6121.807818320517, 6125.500987019177, 6132.6933653317155, 6138.081874382086, 6140.3596453525415, 6142.038385241494, 6155.384461553809, 6176.104464852571, 4920.581750551171, 4932.827351042696, 4944.159492886218, 4955.281484184773, 4969.478204788517, 4366.388705581221, 4401.889952751143, 4432.601065904084, 4462.821487140478, 4491.034427598082, 5620.213170156181, 5699.373068962411, 5701.543876489871, 5745.368009518949, 5790.88418231633, 6237.719302631393, 6299.622022678563, 6307.747690092437, 6310.0, 6323.272823625342, 5812.534997200214, 5817.941820581825, 5819.301683797971, 5833.649981001154, 5871.794487193013, 5269.077911365495, 5347.171188465716, 5411.0, 5419.620626556103, 5426.782928682887, 6288.245410550763, 6290.150829637941, 6292.1505596743855, 6298.842528936813, 6304.369563043659, 6084.452399284086, 6160.476359509492, 6169.043798211284, 6169.290531588925, 6179.412955769195, 6121.087175196906, 6248.156498872776, 6280.685965701788, 6285.402886725754, 6310.432061114522, 5484.7806087757635, 5948.643081415129, 6180.072989051499, 6212.502999760099, 6225.533085018732, 6257.691849616911, 6268.780592679234, 6283.277423096402, 6284.151639528788, 6295.685215739286, 5949.91075133882, 5996.340402555803, 6018.007028840368, 6107.4922612924165, 6123.9232566596775, 6029.306629737636, 6069.666168360783, 6076.33160352352, 6104.156010547632, 6107.735039974651, 5931.288245410578, 5940.584159108821, 5941.31674857397, 5962.70186490665, 6002.159697642246, 5877.0302900021015, 6111.388861113853, 6113.0, 6119.510439164945, 6130.908036379547, 5604.467575580314, 5832.795852145155, 5840.707964601668, 5846.766129354778, 5851.21008663842], "value": 5678.265852387624, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.7954938475224, 508.77613849906015, 509.4065413792931, 511.3327108123898, 529.8834256463578, 29528.0, 39649.801750991275, 39928.60071399285, 39948.600513994854, 42255.57744422562, 42253.78873105638, 42606.0, 42672.14655706884, 42681.0, 42719.78640106803, 9269.258459323271, 9332.973372928973, 9447.90552094477, 9452.149306562407, 9452.763680907963, 9335.206507446876, 9457.527123643791, 9461.290403219786, 9484.715458536255, 9518.286128540352, 9484.288678349118, 9495.430274183536, 9503.0, 9503.097205765442, 9524.333296669236, 9418.434893906388, 9441.575129119206, 9471.242300615968, 9473.763155921088, 9478.052194780466, 9317.39436936597, 9390.812183756287, 9414.717558473258, 9419.152276295097, 9420.717378478657, 39576.01059973524, 39925.60074399277, 39948.20103597912, 39953.601623943316, 40051.399229011586, 3163.9683603163903, 3285.78642388244, 3429.3998550253855, 3527.0476971217886, 3769.1142581493327, 23213.187538436243, 30877.691223087706, 30984.60569274388, 31498.685013149803, 31530.527042094385, 3173.428782819092, 3179.72972297355, 3217.8551965161623, 3337.4660054391425, 3351.447011243142, 484755.0, 485039.0, 486453.0, 486709.56645216903, 504613.4769326167, 30725.692743072283, 31705.0, 56571.43428565744, 57036.0, 57161.71419142878, 33787.83106084454, 34111.14722131967, 34145.487817682755, 34262.0, 34293.14267143291, 12252.632421027205, 14886.032407893452, 14896.925515372353, 14909.403623855142, 14927.029743066665, 12614.05394595409, 12699.428525716365, 12707.872921270853, 12708.173968692005, 12730.108892377444, 7696.461247712607, 7703.614819259126, 7800.375969922506, 7800.765977020698, 7809.297163255334, 2523.6088406297054, 3162.7153556180056, 3207.342494788563, 3212.9357412851614, 3215.1640573450604, 967.1247520993512, 1012.4937531234383, 1021.5300961557618, 1050.375026859033, 1069.9592561897348, 29201.0, 29614.851925740233, 29642.85178574093, 30466.84766576153, 30537.69462305393, 875.4790899414838, 1025.9640912568025, 1070.400575677623, 1088.2327958789035, 1130.5082289204222, 14685.192314422595, 15189.316480758393, 15190.924045379703, 15383.006483870022, 15620.531384058497, 612816.0, 620032.0, 622337.8883105646, 623814.0, 624822.0, 57100.85798284011, 57469.71265143647, 57570.0, 57602.71198644064, 57673.0, 1246.0529997202011, 1279.117408987814, 1287.2662582327982, 1347.279205624986, 1411.4636438153846, 28999.13002609925, 30208.395832083675, 30890.0732978011, 30993.8450307747, 31648.841755791073, 48655.75672121617, 49192.754036231025, 49211.0, 49323.0, 49385.50614493953, 530592.0, 531711.0, 532826.0, 533293.0, 534087.0, 25940.740592593833, 26633.866830665724, 27012.0, 27273.454530908875, 27524.311892202855, 41725.53960611364, 45461.545384547055, 46457.76771116258, 46599.76700116478, 46863.765681171375, 38693.613063869, 38941.805290974495, 39878.2024359517, 40098.0, 40964.79517602393, 38194.0, 38315.2336953265, 38993.0, 39629.00927476721, 39780.403293951196, 30361.696383035887, 37002.0, 37600.62399375971, 38470.038249043995, 38606.80696596499, 26875.596866047417, 31208.063758087294, 33986.15034624154, 34247.0, 34341.14147146241, 21429.678554822003, 24668.87665561661, 24907.252782416555, 25176.49647007013, 25722.0], "value": 18287.25962018972, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.4216691872682, 331.68986997157646, 336.4851776781524, 345.33178299989504, 376.3864900212653, 15145.924270378646, 15862.841371586295, 16208.0, 19965.80205187686, 21261.149554017822, 17910.910445447786, 18387.72418413725, 18550.81449185508, 21276.787232127714, 21483.46291342717, 5651.1523271509295, 5680.545556355502, 5951.732172052247, 5985.940140598604, 6060.545459090586, 5680.772769089232, 6032.487238584704, 6076.483498902577, 6093.878122437549, 6094.969525152368, 5986.431289027535, 6091.025435930252, 6095.329513753483, 6100.176476175704, 6103.23709536308, 5129.358830146231, 5680.6591604503865, 5891.64650120992, 6032.155498230251, 6113.969430152865, 5855.151003104526, 5860.443257890536, 5861.88276234473, 5863.384344643794, 5876.11858221266, 12927.418266178045, 13224.008199385085, 19232.903835480734, 25545.45544662415, 25657.74342256591, 2009.6884982827685, 2243.977560224393, 2334.789868911789, 2411.794997425221, 2583.599542070982, 9933.75165620858, 10464.581416743322, 10466.947665261625, 11216.943915280453, 14781.778273325908, 1718.4844546636084, 1769.513383819447, 1784.4557409989948, 1847.9630407391776, 1868.588910439701, 88862.11137888668, 112751.43624281826, 119131.0, 122172.0, 122886.38556807248, 10933.890661093288, 11066.28069175501, 11117.27737697047, 11664.533418663159, 11721.765564688658, 11278.605248816251, 13084.934575327063, 13626.591202263948, 14322.427102915766, 14471.421143154155, 7350.96324518374, 7377.88933166003, 8661.870071948926, 8670.566471676391, 8801.47191168532, 7237.118349229133, 8218.602837517636, 8668.306535477273, 8808.339374546935, 9003.099690030944, 4547.613452856544, 4565.954340456619, 4573.49691533931, 4599.149157405891, 4641.767911604474, 1897.9051047447572, 1907.2085084689975, 1944.2320283487943, 1953.3651563242004, 1961.0684924660957, 841.995790021046, 845.5307304446092, 898.1018981018981, 922.8892532896095, 926.6756635177634, 16043.0, 20469.488262793548, 20715.792842071387, 21403.0, 21640.891795541236, 919.9954000229956, 941.491594538955, 979.8677178580942, 993.2947607198826, 1002.2683441088046, 9126.0, 9942.403455792532, 10909.83635245456, 11630.302181868945, 11702.531898723955, 582818.0, 589123.0543847253, 593741.0, 608562.0, 617704.0, 135705.64294357126, 138710.0, 140140.0, 142189.0, 144240.27879860534, 976.6093562575027, 1001.1640280365831, 1014.5586669798661, 1017.3793985668736, 1021.3514418344256, 18781.436556903314, 19525.414237572895, 19750.209991600175, 19766.90116549408, 19812.405627831187, 54773.45226547843, 55028.72485637546, 56474.0, 57092.14361784494, 57113.85772284448, 82748.34503310021, 83568.0, 84827.5758621203, 84862.0, 84938.57530712307, 7785.0, 7819.296263336327, 8005.279524842792, 8017.358611311198, 8159.428839981382, 11262.986331230228, 12601.306928119042, 12604.55884044054, 12672.74654506923, 12859.678508037374, 11006.779864402506, 11191.552337906392, 11286.0, 11306.152038596974, 11328.490217940047, 10768.892311077103, 10873.130149588173, 10889.891101088888, 10937.343759374464, 11218.943905280421, 11169.38568378747, 11372.0, 11404.828927565926, 11424.600138995096, 11447.427628618703, 7282.781516554512, 7921.702706215133, 7923.841523169389, 8043.0, 8382.706605268786, 8266.338692904674, 11266.549338026387, 11359.716007099889, 11624.5350185995, 11629.709257268636], "value": 9465.315383231082, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.6156676130686, 1531.4639876043386, 1564.6948844975232, 1770.601614636707, 1917.1085445267947, 7312.744053958112, 7747.264009919063, 7907.881381779278, 8268.751937441886, 8289.502629842214, 8073.0, 8117.107118216992, 8213.383996200293, 8218.95890520548, 8220.0, 2248.179414513707, 2250.5723912456665, 2256.684064231009, 2258.695076164717, 2280.2019293247313, 2229.877356745378, 2264.467850055236, 2272.9545409091807, 2279.894251288124, 2285.737140228878, 2236.7875051870046, 2271.9091236350528, 2278.2481781012225, 2280.532490839374, 2281.8288628352857, 2231.2859884836857, 2244.4052326133587, 2260.886955652211, 2262.162999690109, 2262.7171603549555, 2201.9779802202092, 2202.108146200775, 2208.0, 2210.2706106984815, 2215.601191785478, 8145.185481451807, 8219.83560328796, 8229.135940726257, 8232.670693172266, 8233.259006689366, 4897.559219670246, 5121.0, 5126.974605078962, 5144.56271216947, 5161.071007218699, 2921.532554791223, 3279.8688052477873, 3400.4559270516597, 3476.1309672581856, 3490.2495963367996, 991.8660980767648, 1025.0364657222262, 1030.7320096774818, 1039.0907955538903, 1047.8742550893942, 8901.42140760855, 10433.895661043369, 10526.947365263124, 10594.841077383846, 10625.521851516778, 4100.569440208795, 4232.25935461293, 4296.033392486665, 4328.696991210585, 4330.891727706832, 8441.198086181803, 8465.153484651486, 8468.957655211685, 8485.872711909326, 8498.0, 4942.678725882806, 4955.5044495550155, 4956.8760780980765, 4961.875953101129, 4967.006598680278, 3896.123372241223, 4164.271252530795, 4326.459192600925, 4329.328954012133, 4559.338895860082, 3347.7154441872226, 3602.063463499509, 3608.386574282378, 3626.9818650907105, 3631.473436351714, 978.1832170138015, 1075.956961721538, 1103.2938919091628, 1105.8341248812742, 1113.154002957758, 814.7840822182127, 834.7245409015011, 841.3059226138461, 863.1282404771226, 952.6808519146164, 4705.764711764398, 4896.2655601660035, 5364.624476286701, 5767.480926716616, 5910.99513082777, 895.4224525181222, 911.7538264668635, 917.3991035871514, 960.9855852162223, 983.488585935324, 3799.2021675448464, 3903.2974064668633, 3928.8035598219976, 4035.3543433050572, 4039.111395492987, 9617.326787124834, 9904.950475247722, 9968.501574921225, 9970.800583988279, 9985.151262142654, 9870.358426702242, 9948.154406875352, 9948.900510994798, 9949.80100397988, 9959.850602240973, 7528.811779705551, 7635.770926872203, 7646.694132234648, 7796.220377962159, 7804.102528209215, 5323.64675757763, 5720.199172115824, 5723.456271654186, 5783.710814459344, 5813.505852002627, 8823.60293786794, 8979.236764875059, 9114.498702571156, 9206.217471514996, 9309.534523273674, 9085.500297483703, 9427.670031548863, 9502.952485237529, 9541.141297283279, 9541.47521886303, 6573.868522629425, 6745.392914637706, 6791.89812152828, 6941.861162776817, 7181.784546463615, 7911.446198766032, 7946.006749156356, 7972.0, 7998.600069996361, 7998.880016799636, 6892.931070689229, 7042.577445353295, 7076.893846592202, 7149.60677162761, 7219.8556028880175, 6777.661116944035, 6853.211880633791, 6882.655867206519, 6986.266442023514, 7073.717051318095, 6359.904601431075, 6539.215294164731, 6627.039079333374, 6632.734690612321, 6726.293739157513, 4826.444958829779, 4840.975795121143, 4854.320395144612, 4882.633802464758, 4986.825461108989, 4293.7548111047445, 4843.46721860588, 4852.80588776445, 4956.207006878882, 5149.2276158576515], "value": 4304.158843585661, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.3762727422388, 275.38588946648974, 283.9829610223386, 284.93873817129315, 290.7339784097551, 4340.565943405658, 5150.3047088643025, 5166.819161329354, 5206.895862082756, 5342.130254410954, 4981.5516603505675, 5027.824026159085, 5166.276721259027, 5169.689818610886, 5180.171172612373, 3373.1567108222944, 3391.186115332327, 3782.4893639358747, 3786.4131059685724, 3962.5443074046566, 3077.307605788691, 3736.4208547675153, 3890.610938906115, 4014.498187726534, 4017.296973029708, 3426.5202871597994, 3569.607343192247, 3583.390823560001, 3917.1773927475265, 4001.8199181036925, 3221.3074189049466, 3512.701420379271, 3665.5521069177526, 3858.9228215435814, 3973.920521589581, 3438.850718301062, 3440.2626673529708, 3441.328940856534, 3450.879219227315, 3456.4642480415578, 4728.739919304437, 5145.6398052136365, 5166.741662916839, 5189.870253243699, 5211.791528338862, 4015.859444919443, 4212.978935105305, 4476.709013914117, 4480.686351955364, 4504.346869703874, 5304.363476382859, 5486.451354864522, 5516.531094856942, 5537.916931246034, 5548.140038294071, 3684.9447258291148, 3688.8155592220282, 3692.372296709566, 3700.1674623209833, 3702.2965636528975, 5420.891582168374, 5793.0, 5814.738336774855, 5828.475437210672, 5863.179154918314, 3685.8341374638208, 3728.9813550932613, 3729.6083911188935, 3735.234276973214, 3746.550413950343, 3781.810909454516, 3807.7715337079308, 3807.8667246646232, 3809.561900381492, 3816.37029890065, 3539.292141571696, 4117.890992300794, 4497.707649002804, 4501.572350626685, 4502.311633137573, 5609.382967873531, 5621.831345059655, 5628.521575666115, 5637.295338082739, 5647.837211161763, 1208.6313674329415, 1224.1797995342963, 1283.813846992181, 1310.2662508994993, 1311.9409626566828, 674.5750177388214, 701.4947461891352, 778.6807408962298, 796.6972550430916, 806.3670019035146, 3897.4738410314244, 4427.335899615019, 4435.602785122676, 4475.149721552894, 4528.366028755977, 4050.205358302762, 4482.7810233934415, 4674.462436819741, 4824.324594556765, 4869.488703686062, 3987.601239876047, 4215.704900656986, 4432.84485043022, 4706.493921944944, 5022.949770502321, 2411.493586346887, 2550.7066687330826, 2562.5003124390937, 2857.399946011361, 3024.5311976643657, 5317.341329335332, 5993.220881285492, 6001.789042862048, 6015.488683461867, 6034.5172386209, 5043.621728370314, 5362.946370536322, 5861.677607731615, 5883.734996975585, 5912.645241285537, 4823.662343635911, 5970.432713933051, 5998.760049597967, 6010.797840431844, 6020.969895150496, 4342.609165175149, 5008.69947803133, 5323.9884421959705, 5685.175649530877, 5689.91891540606, 5538.864532770853, 5635.464630860061, 5656.43435656431, 5659.688717120598, 5677.68772717488, 4934.679245849008, 5233.764480598458, 5924.940750592439, 5950.0, 5977.462028417463, 3135.980806237936, 3286.0470463566253, 3535.505029295849, 3683.3001729671278, 3701.3707669695677, 4783.736894470699, 5231.39838918514, 5694.515966142924, 5726.79956201531, 5882.94107060716, 4300.0109974705365, 4722.456917454537, 5276.551493123127, 5352.0366334060245, 5474.343078830566, 5210.426853046238, 5525.917111243254, 5535.750891209825, 5590.580706447114, 5671.886562268649, 4840.370751802243, 5549.556035517229, 5556.388797232382, 5556.972215138899, 5576.302962129734, 5004.4495105537635, 5174.275601415729, 5498.642588231752, 5666.546676265972, 5670.914936275876, 4984.551390374883, 5233.319668443078, 5511.476409741068, 5527.944720552904, 5538.446155384429], "value": 3923.509696137512, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.9964650176752, 719.6186021408652, 769.0463824857179, 804.1114568401912, 825.8513467575835, 15408.152551609672, 15804.051756894594, 15827.683446331066, 15831.604209894758, 15845.762313565307, 14115.717685646281, 14220.928895355508, 14243.287835608204, 14246.928765356184, 14247.430102795875, 701.6526819224491, 731.0532859946355, 731.4806487393956, 876.9693060742875, 882.2412725056462, 891.2112780189547, 896.7847716548047, 907.4645958884257, 911.1207684584375, 911.5670056723037, 964.9131578158, 968.7771812483134, 970.3886551472598, 970.6311601591385, 972.7568107973007, 732.2860211294, 761.8628646843566, 957.0955447102491, 958.8513780364054, 959.2997112108166, 686.8488932434906, 715.3168723868692, 716.6452605960083, 717.2612209424301, 719.0472623773521, 14915.0, 14981.850181498154, 15002.549923502313, 15010.924945375204, 15028.549143525712, 13353.73292534144, 13656.385462654105, 13742.381592828247, 13802.17186968775, 13894.722105557934, 12030.4586293617, 12166.209196402206, 12250.081243906743, 12285.69285767854, 12599.93700031503, 4407.427034485497, 4413.624841888443, 4503.121891231179, 4609.009063051427, 4617.699849509771, 109789.0, 110785.89214107917, 116364.89067077228, 119852.40073799662, 124803.0, 10928.890711092947, 10970.286931349438, 11000.394978276112, 11029.393383363831, 11133.276337038067, 21340.253091141734, 21498.247561335593, 21537.353879383645, 21586.6761998567, 21833.67249491259, 7708.576028318496, 7808.804779880548, 7810.297073263434, 7837.686492540349, 7894.921050789419, 4270.10327831159, 4306.569343065668, 4319.092990472036, 4365.454318210223, 4482.439695038121, 3328.151321413024, 3489.94765078524, 3490.075130090528, 3499.7900125992523, 3501.474778783203, 628.6102616377875, 632.822809613309, 639.3542522052667, 640.897456406982, 645.5481163185789, 603.2338929559435, 614.4224429036781, 643.6009674002148, 649.9772507962199, 656.2223764838682, 8210.261076503024, 8775.868361974575, 8890.110988901188, 9118.800152657393, 9123.406978546373, 499.4442312197551, 584.964902105875, 605.9000264956233, 636.8248731598848, 641.352382554816, 4120.793960301973, 4263.978680106642, 4360.978195109004, 4403.097365040159, 4484.820607175677, 93472.13055738847, 97922.0, 106042.46978765057, 146657.0, 167681.0, 131554.0, 141581.0, 143399.0, 143452.28273858564, 146344.26827865792, 92675.53662231646, 97270.54094188593, 110810.44594777135, 117901.41049294699, 119213.0, 9494.857577136487, 9626.855597166188, 9883.159931405911, 10060.0, 10102.545385457524, 43127.9218019552, 45995.0, 56997.715011426335, 60657.69671151793, 61519.0, 61178.38821611905, 62372.752544949755, 81589.77615335894, 88521.0, 96161.51919240359, 12562.43469043877, 13279.203247805162, 13323.0, 13734.793978090536, 13959.092658977133, 14506.690633113725, 14683.48607798722, 14702.926485367932, 15366.385344586539, 15510.84489155139, 13607.183568985893, 13683.657908552366, 13761.0, 14140.858591414366, 14489.0, 12158.661548981481, 12168.391580420766, 13294.601161965156, 13700.97242706781, 13968.485672579034, 13179.802302965272, 13280.867191327963, 13296.0, 13783.586492405244, 13951.302434878013, 10625.565548651142, 11129.833052504056, 11206.271592346471, 11610.419479025846, 11634.60384753835, 10634.574617015232, 10846.566137354734, 11371.545138194711, 11557.653270401901, 11638.88361116412], "value": 7778.346810962385, "unit": "score"}], "name": "dromaeo_css", "value": 7109.397458721703, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 115.0, 114.0, 115.0, 116.0, 114.0, 115.0, 113.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 114.0, 150.0, 115.0, 113.0, 115.0, 113.0, 144.0, 114.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 185.0, 186.0, 184.0, 185.0, 179.0, 183.0, 181.0, 185.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 89.0, 63.0, 59.0, 59.0, 58.0, 86.0, 58.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 96.0, 70.0, 69.0, 70.0, 94.0, 67.0, 68.0, 91.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 85.0, 87.0, 84.0, 88.0, 85.0, 87.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 103.0, 93.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 78.0, 81.0, 81.0, 81.0, 86.0, 83.0, 81.0, 84.0], "value": 82.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 60.0, 54.0, 56.0, 56.0, 57.0, 57.0, 56.0, 57.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 73.0, 64.0, 79.0, 71.0, 69.0, 67.0, 69.0, 69.0, 71.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 87.0, 93.0, 106.0, 89.0, 86.0, 87.0, 93.0, 87.0, 91.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 145.0, 145.0, 144.0, 146.0, 147.0, 146.0, 191.0, 147.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 171.0, 172.0, 172.0, 172.0, 171.0, 172.0, 171.0, 171.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 67.0, 69.0, 70.0, 69.0, 69.0, 70.0, 75.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1435.7, "alertThreshold": 2.0}]} 04:52:49 INFO - Return code: 0 04:52:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:52:49 INFO - # TBPL SUCCESS # 04:52:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:49 INFO - 2016-10-17 04:52:49.124 screenresolution[2029:279751] starting screenresolution argv=screenresolution get 04:52:49 INFO - 2016-10-17 04:52:49.126 screenresolution[2029:279751] Display 0: 1600x1200x32@60 04:52:49 INFO - 2016-10-17 04:52:49.132 screenresolution[2030:279754] starting screenresolution argv=screenresolution list 04:52:49 INFO - Available Modes on Display 0 04:52:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:49 INFO - Intel Iris: 04:52:49 INFO - Chipset Model: Intel Iris 04:52:49 INFO - Type: GPU 04:52:49 INFO - Bus: Built-In 04:52:49 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:49 INFO - Vendor: Intel (0x8086) 04:52:49 INFO - Device ID: 0x0a2e 04:52:49 INFO - Revision ID: 0x0009 04:52:49 INFO - Displays: 04:52:49 INFO - Display: 04:52:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:49 INFO - Display Serial Number: 1600x1200 60 04:52:49 INFO - Main Display: Yes 04:52:49 INFO - Mirror: Off 04:52:49 INFO - Online: Yes 04:52:49 INFO - Rotation: Supported 04:52:49 INFO - Return code: 0 04:52:49 INFO - Running post-action listener: _resource_record_post_action 04:52:49 INFO - [mozharness: 2016-10-17 11:52:49.371548Z] Finished run-tests step (success) 04:52:49 INFO - Running post-run listener: _resource_record_post_run 04:52:49 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 7925248; Write bytes: 707486720; Read time: 76; Write time: 2045 04:52:49 INFO - TinderboxPrint: CPU usage
53.6% 04:52:49 INFO - TinderboxPrint: I/O read bytes / time
7,925,248 / 76 04:52:49 INFO - TinderboxPrint: I/O write bytes / time
707,486,720 / 2,045 04:52:49 INFO - TinderboxPrint: CPU idle
2,256.4 (46.4%) 04:52:49 INFO - TinderboxPrint: CPU system
971.6 (20.0%) 04:52:49 INFO - TinderboxPrint: CPU user
1,633.7 (33.6%) 04:52:49 INFO - TinderboxPrint: Swap in / out
424,013,824 / 0 04:52:49 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 384883200; Write bytes: 379960832; Read time: 29099; Write time: 715 04:52:49 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 7925248; Write bytes: 297485824; Read time: 76; Write time: 1267 04:52:49 INFO - Running post-run listener: _upload_blobber_files 04:52:49 INFO - Blob upload gear active. 04:52:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:49 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 04:52:49 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:52:49 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:52:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:52:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:51 INFO - (blobuploader) - INFO - Done attempting. 04:52:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:52:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:52:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:52 INFO - (blobuploader) - INFO - Done attempting. 04:52:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:52:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:52:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:54 INFO - (blobuploader) - INFO - Done attempting. 04:52:54 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:54 INFO - Return code: 0 04:52:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa86e3521eaa38e4517faa3e2b1573446bc5cba7fc6e8e1dcfec36e4e32f67be9388bb44cc86fa67b165c46638da659fe39aa8821fa5aa647334f8ea53741051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af17ecb2038e37cd8d5d1cb2f28d15eefbb1ac755d90cdf3fb64f917b0bedbd3c0a2840bb81e52c8ae5c711df4e5301a08769fe02f479dd2822304dc92300c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9d3aea717f967a0ec4258c16021dc3cd15f655ccfc2fd0ac1c6eb80fdc3e797b6e13cb2ae746a08aba8dc9d039dac6d1c029b9ef2ac73a6e5e65facd24ea7b1"} 04:52:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:54 INFO - Contents: 04:52:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa86e3521eaa38e4517faa3e2b1573446bc5cba7fc6e8e1dcfec36e4e32f67be9388bb44cc86fa67b165c46638da659fe39aa8821fa5aa647334f8ea53741051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af17ecb2038e37cd8d5d1cb2f28d15eefbb1ac755d90cdf3fb64f917b0bedbd3c0a2840bb81e52c8ae5c711df4e5301a08769fe02f479dd2822304dc92300c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9d3aea717f967a0ec4258c16021dc3cd15f655ccfc2fd0ac1c6eb80fdc3e797b6e13cb2ae746a08aba8dc9d039dac6d1c029b9ef2ac73a6e5e65facd24ea7b1"} 04:52:54 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:54 INFO - Copying logs to upload dir... 04:52:54 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.903692 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-17 04:52:54.376747) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 04:52:54.380865) ========= 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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa86e3521eaa38e4517faa3e2b1573446bc5cba7fc6e8e1dcfec36e4e32f67be9388bb44cc86fa67b165c46638da659fe39aa8821fa5aa647334f8ea53741051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af17ecb2038e37cd8d5d1cb2f28d15eefbb1ac755d90cdf3fb64f917b0bedbd3c0a2840bb81e52c8ae5c711df4e5301a08769fe02f479dd2822304dc92300c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9d3aea717f967a0ec4258c16021dc3cd15f655ccfc2fd0ac1c6eb80fdc3e797b6e13cb2ae746a08aba8dc9d039dac6d1c029b9ef2ac73a6e5e65facd24ea7b1"} build_url:https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/aYSY7WilQtKLBXWnR-s2Cw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aa86e3521eaa38e4517faa3e2b1573446bc5cba7fc6e8e1dcfec36e4e32f67be9388bb44cc86fa67b165c46638da659fe39aa8821fa5aa647334f8ea53741051", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6af17ecb2038e37cd8d5d1cb2f28d15eefbb1ac755d90cdf3fb64f917b0bedbd3c0a2840bb81e52c8ae5c711df4e5301a08769fe02f479dd2822304dc92300c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b9d3aea717f967a0ec4258c16021dc3cd15f655ccfc2fd0ac1c6eb80fdc3e797b6e13cb2ae746a08aba8dc9d039dac6d1c029b9ef2ac73a6e5e65facd24ea7b1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 04:52:54.413601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 04:52:54.413941) ========= 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.mmdmxHKoCf/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.gN6uq8Nj9a/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005169 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 04:52:54.463134) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 04:52:54.463453) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 04:52:54.463773) ========= ========= Total master_lag: 2.01 =========