builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0034 starttime: 1478549713.71 results: success (0) buildid: 20161107100027 builduid: e4631074dc6d45fbaf9f28f002de049d revision: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:13.710454) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:13.710895) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:13.711181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:13.800844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:13.801142) ========= 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.W71TYprGmo/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.KmPZhOsAA1/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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-11-07 12:15:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2016-11-07 12:15:14 (15.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.634755 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:14.457713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:14.458211) ========= 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.W71TYprGmo/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.KmPZhOsAA1/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.027012 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:14.507327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-07 12:15:14.507636) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a1243da2fec4f351fa1fc5a2314f704f670fd8e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a1243da2fec4f351fa1fc5a2314f704f670fd8e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.W71TYprGmo/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.KmPZhOsAA1/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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-11-07 12:15:14,592 truncating revision to first 12 chars 2016-11-07 12:15:14,592 Setting DEBUG logging. 2016-11-07 12:15:14,592 attempt 1/10 2016-11-07 12:15:14,593 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a1243da2fec4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-07 12:15:15,378 unpacking tar archive at: mozilla-aurora-a1243da2fec4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.050760 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-07 12:15:15.580484) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:15.580761) ========= script_repo_revision: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:15.581143) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:15.581416) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:15.597355) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-07 12:15:15.597666) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.W71TYprGmo/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.KmPZhOsAA1/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 12:15:15 INFO - MultiFileLogger online at 20161107 12:15:15 in /builds/slave/test 12:15:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:15:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:15 INFO - {'append_to_log': False, 12:15:15 INFO - 'base_work_dir': '/builds/slave/test', 12:15:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:15:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:15 INFO - 'branch': 'Mozilla-Aurora', 12:15:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:15 INFO - 'config_files': ('talos/mac_config.py',), 12:15:15 INFO - 'default_actions': ('clobber', 12:15:15 INFO - 'read-buildbot-config', 12:15:15 INFO - 'download-and-extract', 12:15:15 INFO - 'populate-webroot', 12:15:15 INFO - 'create-virtualenv', 12:15:15 INFO - 'install', 12:15:15 INFO - 'run-tests'), 12:15:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:15 INFO - 'download_minidump_stackwalk': True, 12:15:15 INFO - 'download_symbols': 'ondemand', 12:15:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:15 INFO - 'installer_path': 'installer.exe', 12:15:15 INFO - 'log_level': 'info', 12:15:15 INFO - 'log_name': 'talos', 12:15:15 INFO - 'log_to_console': True, 12:15:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:15:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:15:15 INFO - 'opt_config_files': (), 12:15:15 INFO - 'pip_index': False, 12:15:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:15:15 INFO - 'cmd': ('bash', 12:15:15 INFO - '-c', 12:15:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:15:15 INFO - 'enabled': True, 12:15:15 INFO - 'halt_on_failure': False, 12:15:15 INFO - 'name': 'check_screen_resolution'},), 12:15:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:15:15 INFO - 'cmd': ('bash', 12:15:15 INFO - '-c', 12:15:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:15:15 INFO - 'enabled': True, 12:15:15 INFO - 'halt_on_failure': False, 12:15:15 INFO - 'name': 'check_screen_resolution'},), 12:15:15 INFO - 'run_cmd_checks_enabled': True, 12:15:15 INFO - 'sps_profile': False, 12:15:15 INFO - 'sps_profile_interval': 0, 12:15:15 INFO - 'suite': 'dromaeojs', 12:15:15 INFO - 'system_bits': '32', 12:15:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:15 INFO - 'title': 't-yosemite-r7-0034', 12:15:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:15 INFO - 'use_talos_json': True, 12:15:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:15 INFO - 'work_dir': 'build'} 12:15:15 INFO - [mozharness: 2016-11-07 20:15:15.817423Z] Running clobber step. 12:15:15 INFO - Running pre-action listener: _resource_record_pre_action 12:15:15 INFO - Running main action method: clobber 12:15:15 INFO - rmtree: /builds/slave/test/build 12:15:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:18 INFO - Running post-action listener: _resource_record_post_action 12:15:18 INFO - [mozharness: 2016-11-07 20:15:18.193880Z] Finished clobber step (success) 12:15:18 INFO - [mozharness: 2016-11-07 20:15:18.194011Z] Running read-buildbot-config step. 12:15:18 INFO - Running pre-action listener: _resource_record_pre_action 12:15:18 INFO - Running main action method: read_buildbot_config 12:15:18 INFO - Using buildbot properties: 12:15:18 INFO - { 12:15:18 INFO - "project": "", 12:15:18 INFO - "product": "firefox", 12:15:18 INFO - "script_repo_revision": "production", 12:15:18 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 12:15:18 INFO - "repository": "", 12:15:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 12:15:18 INFO - "buildid": "20161107100027", 12:15:18 INFO - "pgo_build": "False", 12:15:18 INFO - "basedir": "/builds/slave/test", 12:15:18 INFO - "buildnumber": 9, 12:15:18 INFO - "slavename": "t-yosemite-r7-0034", 12:15:18 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:15:18 INFO - "platform": "yosemite_r7", 12:15:18 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:15:18 INFO - "branch": "mozilla-aurora", 12:15:18 INFO - "repo_path": "releases/mozilla-aurora", 12:15:18 INFO - "revision": "a1243da2fec4f351fa1fc5a2314f704f670fd8e8", 12:15:18 INFO - "stage_platform": "macosx64", 12:15:18 INFO - "builduid": "e4631074dc6d45fbaf9f28f002de049d", 12:15:18 INFO - "slavebuilddir": "test" 12:15:18 INFO - } 12:15:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 12:15:18 INFO - Running post-action listener: _resource_record_post_action 12:15:18 INFO - [mozharness: 2016-11-07 20:15:18.197462Z] Finished read-buildbot-config step (success) 12:15:18 INFO - [mozharness: 2016-11-07 20:15:18.197583Z] Running download-and-extract step. 12:15:18 INFO - Running pre-action listener: _resource_record_pre_action 12:15:18 INFO - Running main action method: download_and_extract 12:15:18 INFO - mkdir: /builds/slave/test/build/tests 12:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:18 INFO - trying https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 12:15:18 INFO - Downloading https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:15:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 12:15:19 INFO - Downloaded 1199 bytes. 12:15:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:15:19 INFO - Using the following test package requirements: 12:15:19 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:15:19 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:19 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 12:15:19 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:19 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 12:15:19 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:19 INFO - u'jsshell-mac.zip'], 12:15:19 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:19 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 12:15:19 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:15:19 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:19 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 12:15:19 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:19 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 12:15:19 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:19 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 12:15:19 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:19 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 12:15:19 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:15:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:15:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:15:19 INFO - Fetch https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:15:19 INFO - Expected file size: 16423378 12:15:27 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 12:15:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:15:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:15:27 INFO - Fetch https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:15:27 INFO - Expected file size: 16423378 12:15:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 12:15:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:15:34 INFO - Fetch https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 12:15:35 INFO - Expected file size: 14414089 12:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:35 INFO - trying https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:15:35 INFO - Downloading https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 12:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 12:15:38 INFO - Downloaded 115464070 bytes. 12:15:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:15:38 INFO - mkdir: /builds/slave/test/properties 12:15:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:15:38 INFO - Writing to file /builds/slave/test/properties/build_url 12:15:38 INFO - Contents: 12:15:38 INFO - build_url:https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:15:39 INFO - Running post-action listener: _resource_record_post_action 12:15:39 INFO - Running post-action listener: set_extra_try_arguments 12:15:39 INFO - [mozharness: 2016-11-07 20:15:39.517347Z] Finished download-and-extract step (success) 12:15:39 INFO - [mozharness: 2016-11-07 20:15:39.517473Z] Running populate-webroot step. 12:15:39 INFO - Running pre-action listener: _resource_record_pre_action 12:15:39 INFO - Running main action method: populate_webroot 12:15:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:15:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:15:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:15:39 INFO - '--tppagecycles', 12:15:39 INFO - '7'], 12:15:39 INFO - 'tests': ['tsvgm']}}, 12:15:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:15:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:15:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:15:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:15:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:15:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:15:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'talos_options': ['--disable-e10s'], 12:15:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'talos_options': ['--disable-e10s'], 12:15:39 INFO - 'tests': ['damp', 'tps']}, 12:15:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'tests': ['damp', 'tps']}, 12:15:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:15:39 INFO - 'tests': ['dromaeo_dom']}, 12:15:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:15:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:15:39 INFO - 'tests': ['basic_compositor_video']}, 12:15:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:15:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:15:39 INFO - 'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'other-e10s': {'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:15:39 INFO - 'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:15:39 INFO - 'tests': ['a11yr', 12:15:39 INFO - 'ts_paint', 12:15:39 INFO - 'tpaint', 12:15:39 INFO - 'sessionrestore', 12:15:39 INFO - 'sessionrestore_no_auto_restore', 12:15:39 INFO - 'tabpaint']}, 12:15:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:15:39 INFO - 'tests': ['tsvgx', 12:15:39 INFO - 'tsvgr_opacity', 12:15:39 INFO - 'tart', 12:15:39 INFO - 'tscrollx', 12:15:39 INFO - 'cart']}, 12:15:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:15:39 INFO - 'tsvgr_opacity', 12:15:39 INFO - 'tart', 12:15:39 INFO - 'tscrollx', 12:15:39 INFO - 'cart']}, 12:15:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'talos_options': ['--disable-e10s'], 12:15:39 INFO - 'tests': ['tp5o']}, 12:15:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'tests': ['tp5o']}, 12:15:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'talos_options': ['--disable-e10s', 12:15:39 INFO - '--xperf_path', 12:15:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:39 INFO - 'tests': ['tp5n']}, 12:15:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:39 INFO - 'talos_options': ['--xperf_path', 12:15:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:39 INFO - 'tests': ['tp5n']}}, 12:15:39 INFO - 'talos.zip': {'path': '', 12:15:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:15:39 INFO - Running post-action listener: _resource_record_post_action 12:15:39 INFO - [mozharness: 2016-11-07 20:15:39.537546Z] Finished populate-webroot step (success) 12:15:39 INFO - [mozharness: 2016-11-07 20:15:39.537686Z] Running create-virtualenv step. 12:15:39 INFO - Running pre-action listener: _resource_record_pre_action 12:15:39 INFO - Running main action method: create_virtualenv 12:15:39 INFO - Creating virtualenv /builds/slave/test/build/venv 12:15:39 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 12:15:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:15:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:15:39 INFO - Using real prefix '/tools/python27' 12:15:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:15:40 INFO - Installing distribute.............................................................................................................................................................................................done. 12:15:43 INFO - Installing pip.................done. 12:15:43 INFO - Return code: 0 12:15:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:15:43 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')]} 12:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:43 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')]} 12:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:43 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 0x10744b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef89d69980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10725fd30>, '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 0x1070c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107257b20>, '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.W71TYprGmo/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.KmPZhOsAA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 12:15:43 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 12:15:43 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 12:15:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W71TYprGmo/Render', 12:15:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:43 INFO - 'HOME': '/Users/cltbld', 12:15:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:43 INFO - 'LOGNAME': 'cltbld', 12:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:43 INFO - 'MOZ_NO_REMOTE': '1', 12:15:43 INFO - 'NO_EM_RESTART': '1', 12:15:43 INFO - 'PAGER': '/bin/cat', 12:15:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:43 INFO - 'PWD': '/builds/slave/test', 12:15:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:43 INFO - 'SHELL': '/bin/bash', 12:15:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmPZhOsAA1/Listeners', 12:15:43 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 12:15:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:43 INFO - 'USER': 'cltbld', 12:15:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:43 INFO - 'XPC_FLAGS': '0x0', 12:15:43 INFO - 'XPC_SERVICE_NAME': '0', 12:15:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:43 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 12:15:43 INFO - Cleaning up... 12:15:43 INFO - Return code: 0 12:15:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:15:43 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')]} 12:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:43 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')]} 12:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:43 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 0x10744b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef89d69980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10725fd30>, '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 0x1070c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107257b20>, '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.W71TYprGmo/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.KmPZhOsAA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 12:15:43 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 12:15:43 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 12:15:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W71TYprGmo/Render', 12:15:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:43 INFO - 'HOME': '/Users/cltbld', 12:15:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:43 INFO - 'LOGNAME': 'cltbld', 12:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:43 INFO - 'MOZ_NO_REMOTE': '1', 12:15:43 INFO - 'NO_EM_RESTART': '1', 12:15:43 INFO - 'PAGER': '/bin/cat', 12:15:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:43 INFO - 'PWD': '/builds/slave/test', 12:15:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:43 INFO - 'SHELL': '/bin/bash', 12:15:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmPZhOsAA1/Listeners', 12:15:43 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 12:15:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:43 INFO - 'USER': 'cltbld', 12:15:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:43 INFO - 'XPC_FLAGS': '0x0', 12:15:43 INFO - 'XPC_SERVICE_NAME': '0', 12:15:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:44 INFO - Downloading/unpacking psutil>=3.1.1 12:15:44 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 12:15:44 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 12:15:44 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 12:15:44 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 12:15:44 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 12:15:44 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 12:15:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:47 INFO - Installing collected packages: psutil 12:15:47 INFO - Running setup.py install for psutil 12:15:47 INFO - building 'psutil._psutil_osx' extension 12:15:47 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 12:15:48 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 12:15:48 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 12:15:48 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 12:15:48 INFO - building 'psutil._psutil_posix' extension 12:15:48 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 12:15:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:15:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:15:48 INFO - ^ 12:15:48 INFO - 1 warning generated. 12:15:48 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 12:15:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:49 INFO - Successfully installed psutil 12:15:49 INFO - Cleaning up... 12:15:49 INFO - Return code: 0 12:15:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:49 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 0x10744b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef89d69980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10725fd30>, '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 0x1070c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107257b20>, '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.W71TYprGmo/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.KmPZhOsAA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 12:15:49 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 12:15:49 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 12:15:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W71TYprGmo/Render', 12:15:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:49 INFO - 'HOME': '/Users/cltbld', 12:15:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:49 INFO - 'LOGNAME': 'cltbld', 12:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:49 INFO - 'MOZ_NO_REMOTE': '1', 12:15:49 INFO - 'NO_EM_RESTART': '1', 12:15:49 INFO - 'PAGER': '/bin/cat', 12:15:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:49 INFO - 'PWD': '/builds/slave/test', 12:15:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:49 INFO - 'SHELL': '/bin/bash', 12:15:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmPZhOsAA1/Listeners', 12:15:49 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 12:15:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:49 INFO - 'USER': 'cltbld', 12:15:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:49 INFO - 'XPC_FLAGS': '0x0', 12:15:49 INFO - 'XPC_SERVICE_NAME': '0', 12:15:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:15:52 INFO - Installing collected packages: mozsystemmonitor 12:15:52 INFO - Running setup.py install for mozsystemmonitor 12:15:52 INFO - Successfully installed mozsystemmonitor 12:15:52 INFO - Cleaning up... 12:15:52 INFO - Return code: 0 12:15:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:15:52 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')]} 12:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:52 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')]} 12:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:52 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 0x10744b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef89d69980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10725fd30>, '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 0x1070c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107257b20>, '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.W71TYprGmo/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.KmPZhOsAA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 12:15:52 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 12:15:52 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 12:15:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W71TYprGmo/Render', 12:15:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:52 INFO - 'HOME': '/Users/cltbld', 12:15:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:52 INFO - 'LOGNAME': 'cltbld', 12:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:52 INFO - 'MOZ_NO_REMOTE': '1', 12:15:52 INFO - 'NO_EM_RESTART': '1', 12:15:52 INFO - 'PAGER': '/bin/cat', 12:15:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:52 INFO - 'PWD': '/builds/slave/test', 12:15:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:52 INFO - 'SHELL': '/bin/bash', 12:15:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmPZhOsAA1/Listeners', 12:15:52 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 12:15:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:52 INFO - 'USER': 'cltbld', 12:15:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:52 INFO - 'XPC_FLAGS': '0x0', 12:15:52 INFO - 'XPC_SERVICE_NAME': '0', 12:15:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:52 INFO - Downloading/unpacking jsonschema==2.5.1 12:15:52 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 12:15:52 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 12:15:52 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 12:15:52 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 12:15:52 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 12:15:52 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 12:15:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:15:55 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 12:15:55 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 12:15:55 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 12:15:55 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 12:15:55 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 12:15:55 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 12:15:55 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:55 INFO - warning: no files found matching '*.txt' 12:15:55 INFO - no previously-included directories found matching 'build' 12:15:55 INFO - no previously-included directories found matching 'dist' 12:15:55 INFO - no previously-included directories found matching '.git*' 12:15:55 INFO - Installing collected packages: jsonschema, functools32 12:15:55 INFO - Running setup.py install for functools32 12:15:55 INFO - warning: no files found matching '*.txt' 12:15:55 INFO - no previously-included directories found matching 'build' 12:15:55 INFO - no previously-included directories found matching 'dist' 12:15:55 INFO - no previously-included directories found matching '.git*' 12:15:55 INFO - Successfully installed jsonschema functools32 12:15:55 INFO - Cleaning up... 12:15:56 INFO - Return code: 0 12:15:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 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 0x10744b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef89d69980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10725fd30>, '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 0x1070c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107257b20>, '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.W71TYprGmo/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.KmPZhOsAA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 12:15:56 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 12:15:56 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 12:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W71TYprGmo/Render', 12:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:56 INFO - 'HOME': '/Users/cltbld', 12:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:56 INFO - 'LOGNAME': 'cltbld', 12:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:56 INFO - 'MOZ_NO_REMOTE': '1', 12:15:56 INFO - 'NO_EM_RESTART': '1', 12:15:56 INFO - 'PAGER': '/bin/cat', 12:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:56 INFO - 'PWD': '/builds/slave/test', 12:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:56 INFO - 'SHELL': '/bin/bash', 12:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmPZhOsAA1/Listeners', 12:15:56 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 12:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:56 INFO - 'USER': 'cltbld', 12:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:56 INFO - 'XPC_FLAGS': '0x0', 12:15:56 INFO - 'XPC_SERVICE_NAME': '0', 12:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:15:56 INFO - Cleaning up... 12:15:56 INFO - Return code: 0 12:15:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:56 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 0x10744b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef89d69980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10725fd30>, '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 0x1070c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107257b20>, '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.W71TYprGmo/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.KmPZhOsAA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 12:15:56 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 12:15:56 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 12:15:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W71TYprGmo/Render', 12:15:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:56 INFO - 'HOME': '/Users/cltbld', 12:15:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:56 INFO - 'LOGNAME': 'cltbld', 12:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:56 INFO - 'MOZ_NO_REMOTE': '1', 12:15:56 INFO - 'NO_EM_RESTART': '1', 12:15:56 INFO - 'PAGER': '/bin/cat', 12:15:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:56 INFO - 'PWD': '/builds/slave/test', 12:15:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:56 INFO - 'SHELL': '/bin/bash', 12:15:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmPZhOsAA1/Listeners', 12:15:56 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 12:15:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:56 INFO - 'USER': 'cltbld', 12:15:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:56 INFO - 'XPC_FLAGS': '0x0', 12:15:56 INFO - 'XPC_SERVICE_NAME': '0', 12:15:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:59 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:00 INFO - Downloading docopt-0.6.1.tar.gz 12:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:00 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:00 INFO - Running setup.py install for blobuploader 12:16:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:00 INFO - Running setup.py install for requests 12:16:01 INFO - Running setup.py install for docopt 12:16:01 INFO - Successfully installed blobuploader requests docopt 12:16:01 INFO - Cleaning up... 12:16:01 INFO - Return code: 0 12:16:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:01 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 0x10744b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef89d69980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10725fd30>, '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 0x1070c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107257b20>, '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.W71TYprGmo/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.KmPZhOsAA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 12:16:01 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 12:16:01 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 12:16:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W71TYprGmo/Render', 12:16:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:01 INFO - 'HOME': '/Users/cltbld', 12:16:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:01 INFO - 'LOGNAME': 'cltbld', 12:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:01 INFO - 'MOZ_NO_REMOTE': '1', 12:16:01 INFO - 'NO_EM_RESTART': '1', 12:16:01 INFO - 'PAGER': '/bin/cat', 12:16:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:01 INFO - 'PWD': '/builds/slave/test', 12:16:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:01 INFO - 'SHELL': '/bin/bash', 12:16:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmPZhOsAA1/Listeners', 12:16:01 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 12:16:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:01 INFO - 'USER': 'cltbld', 12:16:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:01 INFO - 'XPC_FLAGS': '0x0', 12:16:01 INFO - 'XPC_SERVICE_NAME': '0', 12:16:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:01 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-0HTz8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:01 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-ix8v5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:01 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-hXv4MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-FQxvJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-25MAAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-GLK5iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-G7F43g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-xCSP2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-QHPIpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-0jpjuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-f7ck4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:02 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-5AgrWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-v569Yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-6u6XlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-GJ_YUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-c3FBBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:03 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-GX4N27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:16:03 INFO - Running setup.py install for manifestparser 12:16:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:16:03 INFO - Running setup.py install for mozcrash 12:16:03 INFO - Running setup.py install for mozdebug 12:16:04 INFO - Running setup.py install for mozdevice 12:16:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:16:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:16:04 INFO - Running setup.py install for mozfile 12:16:04 INFO - Running setup.py install for mozhttpd 12:16:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:16:04 INFO - Running setup.py install for mozinfo 12:16:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:16:04 INFO - Running setup.py install for mozInstall 12:16:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:16:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:16:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:16:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:16:04 INFO - Running setup.py install for mozleak 12:16:04 INFO - Running setup.py install for mozlog 12:16:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Running setup.py install for moznetwork 12:16:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Running setup.py install for mozprocess 12:16:05 INFO - Running setup.py install for mozprofile 12:16:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Running setup.py install for mozrunner 12:16:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:16:05 INFO - Running setup.py install for mozscreenshot 12:16:06 INFO - Running setup.py install for moztest 12:16:06 INFO - Running setup.py install for mozversion 12:16:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:16:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:16:06 INFO - Cleaning up... 12:16:06 INFO - Return code: 0 12:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:06 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 0x10744b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef89d69980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10725fd30>, '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 0x1070c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107257b20>, '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.W71TYprGmo/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.KmPZhOsAA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 12:16:06 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 12:16:06 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 12:16:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W71TYprGmo/Render', 12:16:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:06 INFO - 'HOME': '/Users/cltbld', 12:16:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:06 INFO - 'LOGNAME': 'cltbld', 12:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:06 INFO - 'MOZ_NO_REMOTE': '1', 12:16:06 INFO - 'NO_EM_RESTART': '1', 12:16:06 INFO - 'PAGER': '/bin/cat', 12:16:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:06 INFO - 'PWD': '/builds/slave/test', 12:16:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:06 INFO - 'SHELL': '/bin/bash', 12:16:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmPZhOsAA1/Listeners', 12:16:06 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 12:16:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:06 INFO - 'USER': 'cltbld', 12:16:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:06 INFO - 'XPC_FLAGS': '0x0', 12:16:06 INFO - 'XPC_SERVICE_NAME': '0', 12:16:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:16:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-KiZjaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:06 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)) 12:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-hpHAE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:06 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)) 12:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-fycJdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:06 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)) 12:16:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:06 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-DBqeGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:07 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)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-4h0kp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:07 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)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-2mqNXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:07 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)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-SkStuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:07 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)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-mc7LQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:07 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)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-arIhCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:07 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)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-fOpJEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:07 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)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-0QHj11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:07 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)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-phsPQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:07 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)) 12:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:07 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-ZvGOCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:08 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)) 12:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-014_4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:08 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)) 12:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-cNJVY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:08 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)) 12:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-Xj1zX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:08 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)) 12:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:08 INFO - Running setup.py (path:/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/pip-sICUUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:08 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)) 12:16:08 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)) 12:16:08 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)) 12:16:08 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)) 12:16:08 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)) 12:16:08 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)) 12:16:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:11 INFO - Downloading blessings-1.6.tar.gz 12:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:16:11 INFO - Installing collected packages: blessings 12:16:11 INFO - Running setup.py install for blessings 12:16:11 INFO - Successfully installed blessings 12:16:11 INFO - Cleaning up... 12:16:11 INFO - Return code: 0 12:16:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:11 INFO - Reading from file tmpfile_stdout 12:16:11 INFO - Current package versions: 12:16:11 INFO - blessings == 1.6 12:16:11 INFO - blobuploader == 1.2.4 12:16:11 INFO - docopt == 0.6.1 12:16:11 INFO - functools32 == 3.2.3-2 12:16:11 INFO - jsonschema == 2.5.1 12:16:11 INFO - manifestparser == 1.1 12:16:11 INFO - mozInstall == 1.12 12:16:11 INFO - mozcrash == 0.17 12:16:11 INFO - mozdebug == 0.1 12:16:11 INFO - mozdevice == 0.48 12:16:11 INFO - mozfile == 1.2 12:16:11 INFO - mozhttpd == 0.7 12:16:11 INFO - mozinfo == 0.9 12:16:11 INFO - mozleak == 0.1 12:16:11 INFO - mozlog == 3.4 12:16:11 INFO - moznetwork == 0.27 12:16:11 INFO - mozprocess == 0.23 12:16:11 INFO - mozprofile == 0.28 12:16:11 INFO - mozrunner == 6.12 12:16:11 INFO - mozscreenshot == 0.1 12:16:11 INFO - mozsystemmonitor == 0.3 12:16:11 INFO - moztest == 0.7 12:16:11 INFO - mozversion == 1.4 12:16:11 INFO - psutil == 3.1.1 12:16:11 INFO - requests == 1.2.3 12:16:11 INFO - wsgiref == 0.1.2 12:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:11 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 0x10744b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef89d69980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10725fd30>, '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 0x1070c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107257b20>, '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.W71TYprGmo/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.KmPZhOsAA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 12:16:11 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 12:16:11 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 12:16:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W71TYprGmo/Render', 12:16:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:11 INFO - 'HOME': '/Users/cltbld', 12:16:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:11 INFO - 'LOGNAME': 'cltbld', 12:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:11 INFO - 'MOZ_NO_REMOTE': '1', 12:16:11 INFO - 'NO_EM_RESTART': '1', 12:16:11 INFO - 'PAGER': '/bin/cat', 12:16:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:11 INFO - 'PWD': '/builds/slave/test', 12:16:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:11 INFO - 'SHELL': '/bin/bash', 12:16:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmPZhOsAA1/Listeners', 12:16:11 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 12:16:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:11 INFO - 'USER': 'cltbld', 12:16:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:11 INFO - 'XPC_FLAGS': '0x0', 12:16:11 INFO - 'XPC_SERVICE_NAME': '0', 12:16:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:12 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)) 12:16:12 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)) 12:16:12 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)) 12:16:12 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)) 12:16:12 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)) 12:16:12 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)) 12:16:12 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)) 12:16:12 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)) 12:16:12 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)) 12:16:12 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)) 12:16:12 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)) 12:16:12 INFO - Cleaning up... 12:16:12 INFO - Return code: 0 12:16:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:12 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 0x10744b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1073c1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fef89d69980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10725fd30>, '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 0x1070c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107257b20>, '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.W71TYprGmo/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.KmPZhOsAA1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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 12:16:12 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 12:16:12 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 12:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W71TYprGmo/Render', 12:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:12 INFO - 'HOME': '/Users/cltbld', 12:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:12 INFO - 'LOGNAME': 'cltbld', 12:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:12 INFO - 'MOZ_NO_REMOTE': '1', 12:16:12 INFO - 'NO_EM_RESTART': '1', 12:16:12 INFO - 'PAGER': '/bin/cat', 12:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:12 INFO - 'PWD': '/builds/slave/test', 12:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:12 INFO - 'SHELL': '/bin/bash', 12:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmPZhOsAA1/Listeners', 12:16:12 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 12:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:12 INFO - 'USER': 'cltbld', 12:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:12 INFO - 'XPC_FLAGS': '0x0', 12:16:12 INFO - 'XPC_SERVICE_NAME': '0', 12:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:16:12 INFO - Cleaning up... 12:16:12 INFO - Return code: 0 12:16:12 INFO - Running post-action listener: _resource_record_post_action 12:16:12 INFO - Running post-action listener: _start_resource_monitoring 12:16:12 INFO - Starting resource monitoring. 12:16:12 INFO - [mozharness: 2016-11-07 20:16:12.386706Z] Finished create-virtualenv step (success) 12:16:12 INFO - [mozharness: 2016-11-07 20:16:12.387726Z] Running install step. 12:16:12 INFO - Running pre-action listener: _resource_record_pre_action 12:16:12 INFO - Running main action method: install 12:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:12 INFO - Reading from file tmpfile_stdout 12:16:12 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:12 INFO - Reading from file tmpfile_stdout 12:16:12 INFO - Output received: 12:16:12 INFO - Usage: mozinstall [options] installer 12:16:12 INFO - Options: 12:16:12 INFO - -h, --help show this help message and exit 12:16:12 INFO - -d DEST, --destination=DEST 12:16:12 INFO - Directory to install application into. [default: 12:16:12 INFO - "/builds/slave/test"] 12:16:12 INFO - --app=APP Application being installed. [default: firefox] 12:16:12 INFO - mkdir: /builds/slave/test/build/application 12:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 12:16:46 INFO - Reading from file tmpfile_stdout 12:16:46 INFO - Output received: 12:16:46 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:16:46 INFO - Running post-action listener: _resource_record_post_action 12:16:46 INFO - [mozharness: 2016-11-07 20:16:46.545198Z] Finished install step (success) 12:16:46 INFO - [mozharness: 2016-11-07 20:16:46.545346Z] Running run-tests step. 12:16:46 INFO - Running pre-action listener: _resource_record_pre_action 12:16:46 INFO - Running main action method: run_tests 12:16:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:16:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:16:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:16:46 INFO - 2016-11-07 12:16:46.560 screenresolution[1641:8985] starting screenresolution argv=screenresolution get 12:16:46 INFO - 2016-11-07 12:16:46.563 screenresolution[1641:8985] Display 0: 1600x1200x32@60 12:16:46 INFO - 2016-11-07 12:16:46.569 screenresolution[1642:8987] starting screenresolution argv=screenresolution list 12:16:46 INFO - Available Modes on Display 0 12:16:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:16:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:16:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:16:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:16:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:16:46 INFO - Intel Iris: 12:16:46 INFO - Chipset Model: Intel Iris 12:16:46 INFO - Type: GPU 12:16:46 INFO - Bus: Built-In 12:16:46 INFO - VRAM (Dynamic, Max): 1536 MB 12:16:46 INFO - Vendor: Intel (0x8086) 12:16:46 INFO - Device ID: 0x0a2e 12:16:46 INFO - Revision ID: 0x0009 12:16:46 INFO - Displays: 12:16:46 INFO - Display: 12:16:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:16:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:16:46 INFO - Display Serial Number: 1600x1200 60 12:16:46 INFO - Main Display: Yes 12:16:46 INFO - Mirror: Off 12:16:46 INFO - Online: Yes 12:16:46 INFO - Rotation: Supported 12:16:46 INFO - Return code: 0 12:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:46 INFO - Python 2.7.3 12:16:46 INFO - Return code: 0 12:16:46 INFO - grabbing minidump binary from tooltool 12:16:46 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')]} 12:16:46 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 0x10725fd30>, '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 0x1070c5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107257b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:46 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 12:16:46 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 12:16:46 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 12:16:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:46 INFO - Return code: 0 12:16:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:16:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:16:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 12:16:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0034 --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 12:16:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W71TYprGmo/Render', 12:16:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:46 INFO - 'HOME': '/Users/cltbld', 12:16:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:46 INFO - 'LOGNAME': 'cltbld', 12:16:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:46 INFO - 'MOZ_NO_REMOTE': '1', 12:16:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:46 INFO - 'NO_EM_RESTART': '1', 12:16:46 INFO - 'PAGER': '/bin/cat', 12:16:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:46 INFO - 'PWD': '/builds/slave/test', 12:16:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:46 INFO - 'SHELL': '/bin/bash', 12:16:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KmPZhOsAA1/Listeners', 12:16:46 INFO - 'TMPDIR': '/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/', 12:16:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:46 INFO - 'USER': 'cltbld', 12:16:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:46 INFO - 'XPC_FLAGS': '0x0', 12:16:46 INFO - 'XPC_SERVICE_NAME': '0', 12:16:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:16:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0034', '--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 12:16:47 INFO - mozversion application_buildid: 20161107100027 12:16:47 INFO - mozversion application_changeset: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 12:16:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:16:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:47 INFO - mozversion application_name: Firefox 12:16:47 INFO - mozversion application_remotingname: firefox-dev 12:16:47 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:16:47 INFO - mozversion application_vendor: Mozilla 12:16:47 INFO - mozversion application_version: 51.0a2 12:16:47 INFO - mozversion platform_buildid: 20161107100027 12:16:47 INFO - mozversion platform_changeset: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 12:16:47 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:16:47 INFO - mozversion platform_version: 51.0a2 12:16:47 INFO - using testdate: 1478549807 12:16:47 INFO - actual date: 1478549807 12:16:47 INFO - starting webserver on 'localhost:49273' 12:16:47 INFO - SUITE-START | Running 2 tests 12:16:47 INFO - TEST-START | dromaeo_css 12:16:47 INFO - operating with platform_type : mac_ 12:16:47 INFO - Initialising browser for dromaeo_css test... 12:16:47 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmp0vcfwx/profile http://localhost:49273/getInfo.html) 12:16:49 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 12:16:49 INFO - PROCESS | 1652 | colorDepth:24 12:16:49 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 12:16:49 INFO - PROCESS | 1652 | __metrics 12:16:49 INFO - PROCESS | 1652 | 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" 12:16:49 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:16:50 INFO - TEST-INFO | 1652: exit 0 12:16:50 INFO - Browser initialized. 12:16:50 INFO - Running cycle 1/1 for dromaeo_css test... 12:16:50 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmp0vcfwx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:17:02 INFO - PROCESS | 1655 | RSS: Main: 219713536 12:17:02 INFO - PROCESS | 1655 | 12:17:59 INFO - PROCESS | 1655 | 1478549879923 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] 12:20:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 12:20:06 INFO - PROCESS | 1655 | RSS: Main: 347848704 12:20:06 INFO - PROCESS | 1655 | 12:23:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 12:23:10 INFO - PROCESS | 1655 | RSS: Main: 350384128 12:23:10 INFO - PROCESS | 1655 | 12:26:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 12:26:13 INFO - PROCESS | 1655 | RSS: Main: 323063808 12:26:13 INFO - PROCESS | 1655 | 12:29:15 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 12:29:16 INFO - PROCESS | 1655 | RSS: Main: 331202560 12:29:16 INFO - PROCESS | 1655 | 12:32:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 12:32:20 INFO - PROCESS | 1655 | RSS: Main: 308580352 12:32:20 INFO - PROCESS | 1655 | 12:35:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 12:35:24 INFO - PROCESS | 1655 | RSS: Main: 420265984 12:35:24 INFO - PROCESS | 1655 | 12:35:24 INFO - PROCESS | 1655 | __start_tp_report 12:35:24 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 12:35:24 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 12:35:24 INFO - PROCESS | 1655 | |i|pagename|runs| 12:35:24 INFO - PROCESS | 1655 | |0;dojo.html;2885.336372634294;2897.31913000445;2901.0426559235448;2962.377900640864;2981.731644152026;4799.208130658441;4888.535589119028;4924.80300787968;4937.629677774168;4953.900921981558;4852.175130227861;4857.854264372066;4903.926441103386;4906.582940450066;4922.6800257983205;4496.9550304497025;4526.388937493446;4570.634349252052;4573.634109271267;4606.355110284563;4408.5591440855815;4482.574155455227;4500.987277862471;4574.771261436931;4625.8149674013;4551.408316918796;4580.450345958489;4599.034202817395;4616.1229366420275;4621.699589526686;4589.2886602576655;4609.170349337118;4619.445666520006;4620.745858977755;4629.421322334708;4500.167469018242;4503.774811259424;4505;4517.367568540407;4579.702319349231;4890.633202509826;4898.681585696954;4980.377452818398;4986.87532811679;5008.9499105008845;5169.896602067937;5331.653442526223;5366.436524164946;5369.463053694639;5382.515573598395;5228.529432351069;5328.387235467932;5338.679679219259;5346.705931173784;5355.6251062425645;4989.301497790312;4990.800367985276;5005.049040682259;5104.387473503203;5107.668001579886;5514.172874068841;5525.502704756511;5526.281583394133;5531.474509921551;5544.473275038865;4445.911081778347;5052.722100284446;5084.034033533617;5188.610854185951;5263.289455923478;5320.1753728171425;5389.326334208224;5389.622726409192;5395.487428694268;5422.322209723785;5325.893482130413;5329.307190065267;5342.9465705342445;5345.412004679482;5390.245365648812;5130.204818253177;5210.947890521046;5324.6805191687845;5363.329583802025;5383.353997520323;4313.331433627793;4347.500037495665;4373.715708478939;4379.627731642782;4382.07976324969;3866.4200369944733;3951.031997160714;3959.7822119783114;3961.623645753649;3967.988163018412;4747.430308363018;4837.274408838632;4837.37114175155;4838.975805120952;4884.755762211875;5267.841964741064;5302.09864323066;5305.920411193835;5328.147496400557;5334.546563542142;4715;4772.7136371817105;4789.8323558675975;4811.639127065484;4823.879403014883;4009.398590211433;4645.442546894395;4709.364235828188;4719.976400117977;4809.422869255642;4581.908361832811;5636.97181514098;5637.098064309773;5646.955313267059;5646.97176514123;5390.919136212881;5406.243125962447;5442.809501667422;5447.727613619382;5466.4260252674485;5344.572434205332;5416.404195538409;5433.483819037185;5487.862803429946;5491.670499770026;4414.9558504414545;5186.481351864783;5334.146536554133;5337.332833395825;5352.437994010573;5388.568914486753;5389.326334208224;5403.243545903655;5428.430014848542;5463.153211252262;4988.750562471934;5235;5254.264402983662;5260.105782017143;5278.630495865253;5084.542391184811;5101.51535604117;5146.022255771391;5191.143461328838;5253.684778913277;5077.974610127074;5120.692758434506;5125.282460455614;5128.974205158908;5132.307138536399;5198.610104242121;5214.843554693365;5231.319928409434;5234.555062819703;5243.449437808975;4314;4774.474807771212;4935.136351138608;5014.448410674896;5054.7978080876355 12:35:24 INFO - PROCESS | 1655 | |1;ext.html;408.35887656379487;453.2611842696405;456.39755522709993;469.58441779025554;486.67636022045343;30057.797688092476;39462;40420.39369409458;40531;40576.391354129635;41325.760227193154;42034.57965420345;42509;42514.57485425145;42545.14909701812;8092.393070519705;9358.017408172129;9535.71392858212;9541.284403669717;9550.713478595653;8403.327733781314;9795.971423000588;11063.668089957275;11721.941390293037;11996;11746.823797643043;11816.231944923595;11816.409179541031;11820.704482387922;11858.407079646026;8455.112213217646;11712.121590880675;11797.410129493492;11808;11843.052555795559;8238.588070596446;8462.15378462155;8473.618687159093;8479.2792612628;11208.887911120866;37824.05439863998;39615.405768913486;39710.6245969093;39712.80143599292;39805.60194398048;3145.874165033396;3240.8541615627355;3343.6154842193214;3782.375907975181;3793.2603142387247;29374;29572.852135739184;29894.654740536727;30502.847485762428;31448.213794655087;3025.9243518911985;3163.6519982801874;3166.6200055993427;3182.268078341994;3193.632732235776;455819;461128.9999999966;463666;467549;472743;59113.40886591165;59406.702966485755;59579.702101489216;59588;59702;53064.73467632637;60485.69757151186;60749.785004299665;60841.69579152076;60900.69549652223;16071;16775.91612041932;16786.83213167877;16793;16805.83194168067;11621.709457263636;11813.645590632295;12538.498460061677;12800.10399272042;12913.225206487641;15714.057156570414;15829.97105188159;15847.841521584867;15859.841401586067;17828.55428614295;6315.431611155018;6537.600447767134;6642.535022548472;7410.925890741131;7472.85054298911;706.2708897023723;874.5714599846029;916.2944532709777;928.071928071928;972.4408465132577;28442.573361399594;29635.407291854473;29740;30310.69689303123;30859.537106943415;940.5532372123187;959.836827739286;1012.1599072769584;1054.435876805905;1073.8228192348174;14726.63183420423;15267.465638702592;15337.846621533865;15591.532254032398;15642.765358519631;703564;710245;712824;712855.435722818;713290;48142.75928620405;49045.019099617806;55310;56158.71920640452;56281;1283.948642054326;1293.8576756556772;1325.3439547424086;1326.7280207557235;1330.4279159961309;24903.434648343333;29058;29789.404211915207;30236.395272093996;30996.845015774776;47673.80815479641;47968.520314796406;48022.279665804344;48077.519224808704;48091;493707;493895;495230;496132;496256;25079.749202508472;25286.49427011486;25727.742722573283;25769.484610307314;25773.484530309663;45519;45631.77184114058;46155;46178.53821461877;46204.07591848077;36573.53705851843;37071.81464092662;37688.2462350746;37826.810865945496;37895.621043790314;32436;36582.81708591546;37366.439503406924;37390.25219495649;37876;36593.45109823302;36777.63222367742;37306;37592.62407375891;37691.62308376991;31409.68590314159;33431.49852752162;33505.49741753827;33517.16207094842;33666;24701.752982470665;25043.74956250414;25283.620745689197;25739.010453379757;25763.742362576882 12:35:24 INFO - PROCESS | 1655 | |2;jquery.html;286.60162374299716;323.6116660007991;340.3652188668134;352.55225863153794;372.88813355993193;14834.629134271649;15339.616509587251;15852.52442426729;17155.914220428913;19983.90088545133;19124.713129303072;20385.98070096493;20514.897425512852;21453.892730536325;21623.243186488475;5588.720563971795;6644.235912870034;6677.232118306384;6705.932940670604;6719.260881303053;6584.93415065848;6590.967045164767;6670;6703.6983335749765;6787.898181527281;6735.764248251312;6745.865082698343;6746.426553742937;6752.561083529555;6752.966235168818;6560.048792925047;6616.470682345425;6664.4668426526005;6699.430548403391;6785.59286442815;6238.220222472191;6498.252700939405;6539.93460065398;6549.246836613803;6563.57336773113;26497.47005059888;27695.30761730953;27878.581821272695;28294;28598.142055738153;2424.4181396464724;2428.2253901441454;2608.8434693918425;2738.7124351942957;3285.8521366538325;15875.920620396939;16389.754153687703;16402.835971640252;16668;16987.49037528864;1857.823506766855;1980.8415326773822;2006.9197232110698;2025.422754514956;2051.7230173926628;136871;137841.3107934454;139167;139615;142825;15938.60153496172;16506.917465412596;19611.725237859493;20458.488537786376;20632.277870274767;28368.290792730346;29538.6030606483;29630.555541666894;31913.361732765214;33186.3362732744;10455.477226138662;10567.524461399256;10845.403502807421;10927.016568508872;11026.393548354758;7787.961060194662;7936.642851071716;8097.473664211808;8234.341252699889;8245.8350832983;7612.391008719289;8659.567021648892;9321.44071355721;9331.393459425115;9339.392939458914;2936.5448355504504;2947.4252520758246;3514.7522629466685;3586.3544561979093;3604.540161234704;765.7894079128284;768.4044865229492;771.992280077192;820.6512232301249;871.5990644303691;19457.8054219456;20845.791542084688;20935.79064209369;20955.476113097295;21340;845.1843970568308;857.6998050682336;857.811281518065;858.2876212743408;879.1120967822418;10638.787224255471;10886.564537418415;10907.890921090688;10908.127349811995;10911.018008379284;558351;580782;581899;594289;596968;129615;134156;135252;135947;139984;855.4653341661461;943.6084025129632;971.2278738402987;973.0707174648194;974.1086905481405;17500.82499174992;18562.257509699462;19068.618627627093;19104.235830567177;19138.425847224604;54111.45888541064;55570;56107.43892561022;56446;56581;75577.24422755922;77789.61105194438;78585.60707196427;79031.20968790469;80836.5121662217;7625.6568454418575;7632.847343052997;7683.500572462772;7900.762977110696;8019.117897031439;10627.415492148006;12224.449899754354;12444.315562644142;12474.750504989668;12551.88328197018;10697.411642359744;10818.459077045958;10945.23383363157;11051.005409513182;11138.554457821596;10783.838242426213;10833.187510936554;10856.891431085904;10922.672319830417;11098.833517497082;10846.566137354417;10900.6729798103;11037.503312351124;11037.724056898642;11325.207235493437;7594.468387212842;7673.8848917267405;7883.645235964281;8064.8790268147195;8197.77033444988;9854.802903942025;10651.147908167482;10727.463626818784;10881.966213209733;10948.233623646269 12:35:24 INFO - PROCESS | 1655 | |3;mootools.html;1288.8260084888536;1293.4308904082206;1313.5008696695254;1466.6186791434232;1805.3139806873394;7544.245575442453;8091.838163236739;8350.290225330846;8592.527410992392;8596.183362580561;8471.36464765142;8577.914220857789;8585.613647385868;8592.742217733463;8597.699080532182;2254.0645632062715;2312.930612081632;2315.9536809263805;2317.281642690763;2317.455397981473;2281.977180228193;2302.654601809734;2335.754745751697;2340.438294809242;2341.531693661266;2091.1426315210765;2196.1983875885267;2297.540491901618;2310.9422264443438;2320.721513418384;2176.81497072749;2282.1898226129733;2296.127471560796;2301.5166814968875;2303.2284184798195;2001.7898120697262;2265.9320220393415;2284.805791507724;2294;2297.689811875409;8598;8672.739817805475;8676.52279124648;8681.435706679109;8681.739547813575;5011.824586139468;5252.501012403815;5254.553362964152;5308.654937429054;5310;3408.352413041514;3530.75284730069;3611.693006094485;3622.5471816022996;3628.9455658165148;1046.4715318764052;1060.4835085827265;1067.8505009298703;1071.405370019639;1073.6564299424188;11524.539018439253;11525.596604118899;11630.94184529072;11640.417979101096;11646.767064658745;4288.807003684779;4400.977995110004;4493.348464472699;4508.436445444319;4518.254488009507;8734.475931444134;8738.781530461789;8803.471791692518;8817.691380801642;8897.065808090187;5083.034223497598;5083.822066227738;5097.821576244888;5102;5102.158143906288;4225.598568136023;4285.892852678708;4372.672049596293;4385.342198670225;4787.569118779326;3109.875604975776;3636.636336366342;3689.723270754704;3762.097096696773;3779.3952967525065;1123.8370436286693;1129.7966366054188;1135.0862555642786;1143.3368646185193;1167.486306025346;659.7822718502882;687.9965600172068;783.7844592737043;805.3597390074905;839.6263662670053;5413.593980451482;5590.161475778666;5687.175359572839;5758.798442054592;5785.392533783892;391.70622033474893;399.4806751223456;410.1591736939263;419.6013786902455;423.81140392525646;3785.2997195518365;3861.5945325740954;3887.7084218683713;3902.083010492532;3908.843646254118;8814.427062240933;10118.696439106838;10530.210234232463;10538.473076346152;10539.894601053891;8904.421212621159;9842.212622990144;10321.174306055498;10326.070653641209;10487;7612.467127301146;7716.035495563055;7726.922730772732;7840.843183136305;7845.764627061198;5743.483086522233;5791.739371728198;5805.82582522525;5862.075856280574;6034.974054410673;9696.466694331879;9857.16214121779;9869.605215791287;9872.062154095349;9878.604855805686;9071.727848164566;9886.209103271578;10049.849252261076;10148.188144948239;10189.592416303562;6744.460443164437;6958.652067396712;7115.53749006313;7246.89129663045;7340.302671246437;8024.438289319692;8026.077001144709;8068.394870384627;8131.715389961323;8138.959305203436;6153.2000839890525;7310.9634451829525;7329.633518324169;7373.963130184315;7395.445341599294;7067.57594544329;7195.2085270619145;7204.53170543913;7218.783436496913;7249.891251631335;6767.661616919036;6902.171739391305;6908.930910690829;6915.930840691529;6916.273791251846;4785.880352991064;4789.744663247568;4906.705597664151;4936.160852655129;5051.62112841531;4062.9390559141048;4838.830640927551;4875.585575226146;4882.7314497701545;5049.949500505095 12:35:24 INFO - PROCESS | 1655 | |4;prototype.html;266.630716457706;270.77525653707426;280.2098083404798;281.6999895111706;285.14030198950155;3250.4961730931686;3604.4773507841346;4083.8162282697276;4101.241270364984;4132.607402296777;3872.341701910675;4002.879913602589;4023.657989070925;4064.4106604542326;4076.9592304077023;3233.6604656510963;3255.251292202795;3266.2035880265876;3270.771046026779;3281.983590082058;2678.866056697167;2824.4209936962975;3268.9019329420157;3286.622038465571;3315.6293250326135;2947.233719233004;3011.6988301169927;3181.9499565143565;3190.6649801770827;3252.1544398456454;3203.6475987641343;3210.5344725014743;3220.983895080533;3221.307418904935;3247.967520324802;2840.957385639217;2848.3875966667265;2856.8000239983207;2859.4567032263803;2878.553824157238;3536.885880947493;3628.872989445357;3914.256291304643;3930.5872883347124;3943.2902077626018;3111.9222019449467;3376.898693039213;3632.5096112024803;3643.6174201708704;3687.1703866630064;4343.956560434387;4351.26028575143;4373.332267316934;4381.737095774264;4382.8904277393;3131.5302704594264;3146.197719581515;3146.9615027041023;3147.3547922676025;3170.8573114209917;3821.1211421372964;4444;4464.821407143743;4468.4637843458995;4504.459464864204;2677.942212825923;2768.7784977201777;2881.3516958684127;3160.2099475131217;3222.564953731216;2450.277168235375;3160.6365267994474;3310.354480876206;3339.666033396641;3341.396129857682;3314.3537010283244;3537.4163263061305;3696.852125914987;3712.406015037581;3766.6610005099674;4394.428724265889;4432.778361081933;4433.290673492225;4438.716638443917;4484.932726009112;1067.3275836223129;1082.24783775277;1084.2356138922041;1098.6154845803906;1110.666799960025;622.7166639179162;703.1702590942634;727.5961841178091;778.2256654628568;809.4414853750893;3874.9612503875164;3902.492675952108;3950.7827069511454;3982.721209515364;4007.3369551635747;4359.542248063971;4422.827950593095;4475.149721552894;4567.223571992769;4578.88552786183;3789.5642001169667;3853.6917046636204;4023.3361495352938;4033.616806403387;4114.465119534441;1766.8498177655044;1958.8452702027655;2168.7421295648487;2331.661909023182;2388.8686122263443;4580.4045474088825;4587.669575822974;4588.036512332447;4654.581087702055;4789.700943547047;3793.867214647474;4468.6931670563545;4539.568740969603;4541.02367990877;4577.496475387705;3561.8397172127316;3839.9424008639894;4373.934390984138;4602.470715867718;4614.907701845877;3712.6287371262656;4536.5236650151255;4579.38178345919;4604.861854144381;4629;4413.955860441483;4416.271315232951;4423.513413524445;4427.80074896624;4549.385832912514;4172.70791044624;4479.148961697267;4596.3105534170145;4658.487566367765;4750.904981900274;2674.2378422150373;3170.3659268146926;3198.248411623313;3210.727088197529;3215.5658986036588;4118.485189351331;4478.328250762412;4493.101379724003;4510.1656193604285;4512;4188.910473774379;4410.536893626123;4433.674743942043;4440.956375251878;4449.9542607487865;3629.2560025194243;3939.3500072488864;4387.8315600180595;4413.40419043425;4425.871402792396;3651.214988777426;4315.187621199041;4329.76186309756;4331.956680433155;4334.1981733379425;3520.647935206561;4223.472065991751;4313.266744653479;4323.805428755651;4361;3686.594474607845;3935.9103104063174;4165.687573431944;4431.689781715378;4458.598726114666 12:35:24 INFO - PROCESS | 1655 | |5;yui.html;673.807964730052;723.1900271695702;723.7828651404578;728.6757392960131;750.7109762741343;14428.35072421741;15552.300146493406;15571.68856622867;15623.921880390597;15675.60810979726;13965.650858728537;14137.151770893754;14148.50480233192;14154.858451415483;14198.219097949608;645.3578689204224;667.6995352091554;669.7622344067859;801.1667865419971;802.1577343789028;822.2065706593137;824.1140773668301;836.0051538668964;837.3092198935872;838.4801423117675;875.1685898396516;889.1064480197392;894.0523045571682;894.3247847874845;896.6771962093641;669.5012215899186;689.018149137482;888.7511496780912;891.572045418203;892.6340200517789;627.2410383436048;641.6727468990802;643.9710213040424;648.5298158834808;650.1710319342828;14654.340554675066;14681;14693.632659183499;14693.632659183499;14726.190059546721;13217.73564528704;13307.135036222615;13443.32783360828;13627.869993042461;14049.859501404957;8375.41372103953;10733;10806.243562950596;11494.88505114955;11740.941295293555;4263.914721705549;4284.464441944757;4361.760103194323;4642.396488456513;4652.395188625457;95092;97329.5133524335;98633.0136698631;104363;106735.46632266867;10121.898781012243;10290.073893349634;10401.375917444977;10474.633387831389;10805.621803236849;19616.509587260432;19785.60428791416;19825.900870495556;19830.305939292055;19834.50413739668;7507.624618769039;7596.050493688289;7619.771406857803;7701.884471732928;7714.884276735854;4154.459920210354;4203.306454435045;4225.915481690349;4268.146370725867;4273.722208056466;3242.8702851886133;3723.1622884851236;3874.1089549403796;3914.8042597869994;3946.5856085111222;700.7617410080597;701.1901254051579;704.7744721689011;709.0888208651858;719.9928000720031;519.7037688517509;546.4562760053772;613.0130489911239;614.620177701064;621.7450845153465;8594.613242404106;8807.69173078952;9265.119813617695;9387.906120938704;9514.38156519824;464.85120301310667;471.75468756247244;534.4228233507803;552.3013388064102;613.5183880653666;4105.568915263854;4470.585903432994;4475.70907890986;4596.034832685106;4618.538146185422;126672.36663816807;130437;132241.33879330542;142564;143437.28281358734;92721;107441.46279268553;109110;111128.4443577777;114680;71467;97315;104760.47619761853;105117;106580;7661.693532258871;9593.90406095958;9616.23070154372;9681.612735490502;9755;45464.54535454603;55596;57931;58315.708421457624;59729.701351492964;86888.56555717181;90304.08088841291;90757.18485630119;92252;96656;12540.623781286577;12617.873821262037;12680.302583358003;13068.934655327042;13081.7183832725;13683.384247709077;13918.51285205013;13986.230757308038;14580.927095364455;15423.228838558252;11910.344931028876;13608.251546165056;13742.793858091936;13769;13879.167249965034;13034.674133146747;13225.603231903058;13666.794998075236;13973.720525589635;14452.843772498385;13101.672458188621;13800.03399762007;13898.23559704226;13999.16005039701;14012.859871401562;9729.367591106555;10179.949100254747;10200.3369780964;10501.789964200825;11161.72095697614;9073.637054517745;10921.78156436851;11184.273022253528;11269.380184089627;11335.773284534429 12:35:24 INFO - PROCESS | 1655 | __end_tp_report 12:35:24 INFO - PROCESS | 1655 | __start_cc_report 12:35:24 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1232 12:35:24 INFO - PROCESS | 1655 | __end_cc_report 12:35:24 INFO - PROCESS | 1655 | __startTimestamp1478550924070__endTimestamp 12:35:24 INFO - PROCESS | 1655 | 12:35:24 INFO - PROCESS | 1655 | ------- Summary: start ------- 12:35:24 INFO - PROCESS | 1655 | Number of tests: 6 12:35:24 INFO - PROCESS | 1655 | 12:35:24 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:4934.97 Median:5054.80 stddev:535.41 (10.6%) stddev-sans-first:512.34 12:35:24 INFO - PROCESS | 1655 | Values: 2885.3 2897.3 2901.0 2962.4 2981.7 4799.2 4888.5 4924.8 4937.6 4953.9 4852.2 4857.9 4903.9 4906.6 4922.7 4497.0 4526.4 4570.6 4573.6 4606.4 4408.6 4482.6 4501.0 4574.8 4625.8 4551.4 4580.5 4599.0 4616.1 4621.7 4589.3 4609.2 4619.4 4620.7 4629.4 4500.2 4503.8 4505.0 4517.4 4579.7 4890.6 4898.7 4980.4 4986.9 5008.9 5169.9 5331.7 5366.4 5369.5 5382.5 5228.5 5328.4 5338.7 5346.7 5355.6 4989.3 4990.8 5005.0 5104.4 5107.7 5514.2 5525.5 5526.3 5531.5 5544.5 4445.9 5052.7 5084.0 5188.6 5263.3 5320.2 5389.3 5389.6 5395.5 5422.3 5325.9 5329.3 5342.9 5345.4 5390.2 5130.2 5210.9 5324.7 5363.3 5383.4 4313.3 4347.5 4373.7 4379.6 4382.1 3866.4 3951.0 3959.8 3961.6 3968.0 4747.4 4837.3 4837.4 4839.0 4884.8 5267.8 5302.1 5305.9 5328.1 5334.5 4715.0 4772.7 4789.8 4811.6 4823.9 4009.4 4645.4 4709.4 4720.0 4809.4 4581.9 5637.0 5637.1 5647.0 5647.0 5390.9 5406.2 5442.8 5447.7 5466.4 5344.6 5416.4 5433.5 5487.9 5491.7 4415.0 5186.5 5334.1 5337.3 5352.4 5388.6 5389.3 5403.2 5428.4 5463.2 4988.8 5235.0 5254.3 5260.1 5278.6 5084.5 5101.5 5146.0 5191.1 5253.7 5078.0 5120.7 5125.3 5129.0 5132.3 5198.6 5214.8 5231.3 5234.6 5243.4 4314.0 4774.5 4935.1 5014.4 5054.8 12:35:24 INFO - PROCESS | 1655 | 12:35:24 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:68563.48 Median:37689.93 stddev:151897.84 (403.0%) stddev-sans-first:152237.76 12:35:24 INFO - PROCESS | 1655 | Values: 408.4 453.3 456.4 469.6 486.7 30057.8 39462.0 40420.4 40531.0 40576.4 41325.8 42034.6 42509.0 42514.6 42545.1 8092.4 9358.0 9535.7 9541.3 9550.7 8403.3 9796.0 11063.7 11721.9 11996.0 11746.8 11816.2 11816.4 11820.7 11858.4 8455.1 11712.1 11797.4 11808.0 11843.1 8238.6 8462.2 8473.6 8479.3 11208.9 37824.1 39615.4 39710.6 39712.8 39805.6 3145.9 3240.9 3343.6 3782.4 3793.3 29374.0 29572.9 29894.7 30502.8 31448.2 3025.9 3163.7 3166.6 3182.3 3193.6 455819.0 461129.0 463666.0 467549.0 472743.0 59113.4 59406.7 59579.7 59588.0 59702.0 53064.7 60485.7 60749.8 60841.7 60900.7 16071.0 16775.9 16786.8 16793.0 16805.8 11621.7 11813.6 12538.5 12800.1 12913.2 15714.1 15830.0 15847.8 15859.8 17828.6 6315.4 6537.6 6642.5 7410.9 7472.9 706.3 874.6 916.3 928.1 972.4 28442.6 29635.4 29740.0 30310.7 30859.5 940.6 959.8 1012.2 1054.4 1073.8 14726.6 15267.5 15337.8 15591.5 15642.8 703564.0 710245.0 712824.0 712855.4 713290.0 48142.8 49045.0 55310.0 56158.7 56281.0 1283.9 1293.9 1325.3 1326.7 1330.4 24903.4 29058.0 29789.4 30236.4 30996.8 47673.8 47968.5 48022.3 48077.5 48091.0 493707.0 493895.0 495230.0 496132.0 496256.0 25079.7 25286.5 25727.7 25769.5 25773.5 45519.0 45631.8 46155.0 46178.5 46204.1 36573.5 37071.8 37688.2 37826.8 37895.6 32436.0 36582.8 37366.4 37390.3 37876.0 36593.5 36777.6 37306.0 37592.6 37691.6 31409.7 33431.5 33505.5 33517.2 33666.0 24701.8 25043.7 25283.6 25739.0 25763.7 12:35:24 INFO - PROCESS | 1655 | 12:35:24 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:36515.87 Median:2941.99 stddev:97954.57 (3329.5%) stddev-sans-first:98191.59 12:35:24 INFO - PROCESS | 1655 | Values: 286.6 323.6 340.4 352.6 372.9 14834.6 15339.6 15852.5 17155.9 19983.9 19124.7 20386.0 20514.9 21453.9 21623.2 5588.7 6644.2 6677.2 6705.9 6719.3 6584.9 6591.0 6670.0 6703.7 6787.9 6735.8 6745.9 6746.4 6752.6 6753.0 6560.0 6616.5 6664.5 6699.4 6785.6 6238.2 6498.3 6539.9 6549.2 6563.6 26497.5 27695.3 27878.6 28294.0 28598.1 2424.4 2428.2 2608.8 2738.7 3285.9 15875.9 16389.8 16402.8 16668.0 16987.5 1857.8 1980.8 2006.9 2025.4 2051.7 136871.0 137841.3 139167.0 139615.0 142825.0 15938.6 16506.9 19611.7 20458.5 20632.3 28368.3 29538.6 29630.6 31913.4 33186.3 10455.5 10567.5 10845.4 10927.0 11026.4 7788.0 7936.6 8097.5 8234.3 8245.8 7612.4 8659.6 9321.4 9331.4 9339.4 2936.5 2947.4 3514.8 3586.4 3604.5 765.8 768.4 772.0 820.7 871.6 19457.8 20845.8 20935.8 20955.5 21340.0 845.2 857.7 857.8 858.3 879.1 10638.8 10886.6 10907.9 10908.1 10911.0 558351.0 580782.0 581899.0 594289.0 596968.0 129615.0 134156.0 135252.0 135947.0 139984.0 855.5 943.6 971.2 973.1 974.1 17500.8 18562.3 19068.6 19104.2 19138.4 54111.5 55570.0 56107.4 56446.0 56581.0 75577.2 77789.6 78585.6 79031.2 80836.5 7625.7 7632.8 7683.5 7900.8 8019.1 10627.4 12224.4 12444.3 12474.8 12551.9 10697.4 10818.5 10945.2 11051.0 11138.6 10783.8 10833.2 10856.9 10922.7 11098.8 10846.6 10900.7 11037.5 11037.7 11325.2 7594.5 7673.9 7883.6 8064.9 8197.8 9854.8 10651.1 10727.5 10882.0 10948.2 12:35:24 INFO - PROCESS | 1655 | 12:35:24 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5478.68 Median:4894.72 stddev:3112.12 (63.6%) stddev-sans-first:3104.92 12:35:24 INFO - PROCESS | 1655 | Values: 1288.8 1293.4 1313.5 1466.6 1805.3 7544.2 8091.8 8350.3 8592.5 8596.2 8471.4 8577.9 8585.6 8592.7 8597.7 2254.1 2312.9 2316.0 2317.3 2317.5 2282.0 2302.7 2335.8 2340.4 2341.5 2091.1 2196.2 2297.5 2310.9 2320.7 2176.8 2282.2 2296.1 2301.5 2303.2 2001.8 2265.9 2284.8 2294.0 2297.7 8598.0 8672.7 8676.5 8681.4 8681.7 5011.8 5252.5 5254.6 5308.7 5310.0 3408.4 3530.8 3611.7 3622.5 3628.9 1046.5 1060.5 1067.9 1071.4 1073.7 11524.5 11525.6 11630.9 11640.4 11646.8 4288.8 4401.0 4493.3 4508.4 4518.3 8734.5 8738.8 8803.5 8817.7 8897.1 5083.0 5083.8 5097.8 5102.0 5102.2 4225.6 4285.9 4372.7 4385.3 4787.6 3109.9 3636.6 3689.7 3762.1 3779.4 1123.8 1129.8 1135.1 1143.3 1167.5 659.8 688.0 783.8 805.4 839.6 5413.6 5590.2 5687.2 5758.8 5785.4 391.7 399.5 410.2 419.6 423.8 3785.3 3861.6 3887.7 3902.1 3908.8 8814.4 10118.7 10530.2 10538.5 10539.9 8904.4 9842.2 10321.2 10326.1 10487.0 7612.5 7716.0 7726.9 7840.8 7845.8 5743.5 5791.7 5805.8 5862.1 6035.0 9696.5 9857.2 9869.6 9872.1 9878.6 9071.7 9886.2 10049.8 10148.2 10189.6 6744.5 6958.7 7115.5 7246.9 7340.3 8024.4 8026.1 8068.4 8131.7 8139.0 6153.2 7311.0 7329.6 7374.0 7395.4 7067.6 7195.2 7204.5 7218.8 7249.9 6767.7 6902.2 6908.9 6915.9 6916.3 4785.9 4789.7 4906.7 4936.2 5051.6 4062.9 4838.8 4875.6 4882.7 5049.9 12:35:24 INFO - PROCESS | 1655 | 12:35:24 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:3565.82 Median:3937.63 stddev:1078.87 (27.4%) stddev-sans-first:1053.09 12:35:24 INFO - PROCESS | 1655 | Values: 266.6 270.8 280.2 281.7 285.1 3250.5 3604.5 4083.8 4101.2 4132.6 3872.3 4002.9 4023.7 4064.4 4077.0 3233.7 3255.3 3266.2 3270.8 3282.0 2678.9 2824.4 3268.9 3286.6 3315.6 2947.2 3011.7 3181.9 3190.7 3252.2 3203.6 3210.5 3221.0 3221.3 3248.0 2841.0 2848.4 2856.8 2859.5 2878.6 3536.9 3628.9 3914.3 3930.6 3943.3 3111.9 3376.9 3632.5 3643.6 3687.2 4344.0 4351.3 4373.3 4381.7 4382.9 3131.5 3146.2 3147.0 3147.4 3170.9 3821.1 4444.0 4464.8 4468.5 4504.5 2677.9 2768.8 2881.4 3160.2 3222.6 2450.3 3160.6 3310.4 3339.7 3341.4 3314.4 3537.4 3696.9 3712.4 3766.7 4394.4 4432.8 4433.3 4438.7 4484.9 1067.3 1082.2 1084.2 1098.6 1110.7 622.7 703.2 727.6 778.2 809.4 3875.0 3902.5 3950.8 3982.7 4007.3 4359.5 4422.8 4475.1 4567.2 4578.9 3789.6 3853.7 4023.3 4033.6 4114.5 1766.8 1958.8 2168.7 2331.7 2388.9 4580.4 4587.7 4588.0 4654.6 4789.7 3793.9 4468.7 4539.6 4541.0 4577.5 3561.8 3839.9 4373.9 4602.5 4614.9 3712.6 4536.5 4579.4 4604.9 4629.0 4414.0 4416.3 4423.5 4427.8 4549.4 4172.7 4479.1 4596.3 4658.5 4750.9 2674.2 3170.4 3198.2 3210.7 3215.6 4118.5 4478.3 4493.1 4510.2 4512.0 4188.9 4410.5 4433.7 4441.0 4450.0 3629.3 3939.4 4387.8 4413.4 4425.9 3651.2 4315.2 4329.8 4332.0 4334.2 3520.6 4223.5 4313.3 4323.8 4361.0 3686.6 3935.9 4165.7 4431.7 4458.6 12:35:24 INFO - PROCESS | 1655 | 12:35:24 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:22867.03 Median:4266.03 stddev:35465.72 (831.4%) stddev-sans-first:35526.06 12:35:24 INFO - PROCESS | 1655 | Values: 673.8 723.2 723.8 728.7 750.7 14428.4 15552.3 15571.7 15623.9 15675.6 13965.7 14137.2 14148.5 14154.9 14198.2 645.4 667.7 669.8 801.2 802.2 822.2 824.1 836.0 837.3 838.5 875.2 889.1 894.1 894.3 896.7 669.5 689.0 888.8 891.6 892.6 627.2 641.7 644.0 648.5 650.2 14654.3 14681.0 14693.6 14693.6 14726.2 13217.7 13307.1 13443.3 13627.9 14049.9 8375.4 10733.0 10806.2 11494.9 11740.9 4263.9 4284.5 4361.8 4642.4 4652.4 95092.0 97329.5 98633.0 104363.0 106735.5 10121.9 10290.1 10401.4 10474.6 10805.6 19616.5 19785.6 19825.9 19830.3 19834.5 7507.6 7596.1 7619.8 7701.9 7714.9 4154.5 4203.3 4225.9 4268.1 4273.7 3242.9 3723.2 3874.1 3914.8 3946.6 700.8 701.2 704.8 709.1 720.0 519.7 546.5 613.0 614.6 621.7 8594.6 8807.7 9265.1 9387.9 9514.4 464.9 471.8 534.4 552.3 613.5 4105.6 4470.6 4475.7 4596.0 4618.5 126672.4 130437.0 132241.3 142564.0 143437.3 92721.0 107441.5 109110.0 111128.4 114680.0 71467.0 97315.0 104760.5 105117.0 106580.0 7661.7 9593.9 9616.2 9681.6 9755.0 45464.5 55596.0 57931.0 58315.7 59729.7 86888.6 90304.1 90757.2 92252.0 96656.0 12540.6 12617.9 12680.3 13068.9 13081.7 13683.4 13918.5 13986.2 14580.9 15423.2 11910.3 13608.3 13742.8 13769.0 13879.2 13034.7 13225.6 13666.8 13973.7 14452.8 13101.7 13800.0 13898.2 13999.2 14012.9 9729.4 10179.9 10200.3 10501.8 11161.7 9073.6 10921.8 11184.3 11269.4 11335.8 12:35:24 INFO - PROCESS | 1655 | -------- Summary: end -------- 12:35:24 INFO - PROCESS | 1655 | 12:35:24 INFO - TEST-INFO | 1655: exit 0 12:35:24 INFO - TEST-OK | dromaeo_css | took 1117664ms 12:35:24 INFO - TEST-START | kraken 12:35:24 INFO - operating with platform_type : mac_ 12:35:24 INFO - Initialising browser for kraken test... 12:35:24 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmp0CpOIh/profile http://localhost:49273/getInfo.html) 12:35:27 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 12:35:27 INFO - PROCESS | 1662 | colorDepth:24 12:35:27 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 12:35:27 INFO - PROCESS | 1662 | __metrics 12:35:27 INFO - PROCESS | 1662 | 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" 12:35:27 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:28 INFO - TEST-INFO | 1662: exit 0 12:35:28 INFO - Browser initialized. 12:35:28 INFO - Running cycle 1/1 for kraken test... 12:35:28 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/T/tmp0CpOIh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:40 INFO - PROCESS | 1663 | RSS: Main: 219779072 12:35:40 INFO - PROCESS | 1663 | 12:35:43 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:44 INFO - PROCESS | 1663 | RSS: Main: 269668352 12:35:44 INFO - PROCESS | 1663 | 12:35:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 12:35:47 INFO - PROCESS | 1663 | RSS: Main: 280567808 12:35:47 INFO - PROCESS | 1663 | 12:35:50 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 12:35:51 INFO - PROCESS | 1663 | RSS: Main: 378294272 12:35:51 INFO - PROCESS | 1663 | 12:35:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 12:35:54 INFO - PROCESS | 1663 | RSS: Main: 279613440 12:35:54 INFO - PROCESS | 1663 | 12:35:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:56 INFO - PROCESS | 1663 | RSS: Main: 280141824 12:35:56 INFO - PROCESS | 1663 | 12:35:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 12:36:00 INFO - PROCESS | 1663 | RSS: Main: 318865408 12:36:00 INFO - PROCESS | 1663 | 12:36:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 12:36:04 INFO - PROCESS | 1663 | RSS: Main: 317235200 12:36:04 INFO - PROCESS | 1663 | 12:36:06 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 12:36:07 INFO - PROCESS | 1663 | RSS: Main: 317759488 12:36:07 INFO - PROCESS | 1663 | 12:36:09 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:09 INFO - PROCESS | 1663 | RSS: Main: 290222080 12:36:09 INFO - PROCESS | 1663 | 12:36:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:12 INFO - PROCESS | 1663 | RSS: Main: 295043072 12:36:12 INFO - PROCESS | 1663 | 12:36:14 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:15 INFO - PROCESS | 1663 | RSS: Main: 298590208 12:36:15 INFO - PROCESS | 1663 | 12:36:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:19 INFO - PROCESS | 1663 | RSS: Main: 308666368 12:36:19 INFO - PROCESS | 1663 | 12:36:22 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:22 INFO - PROCESS | 1663 | RSS: Main: 308871168 12:36:22 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 12:36:24 INFO - PROCESS | 1663 | RSS: Main: 352378880 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | __start_tp_report 12:36:24 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 12:36:24 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 12:36:24 INFO - PROCESS | 1663 | |i|pagename|runs| 12:36:24 INFO - PROCESS | 1663 | |0;ai-astar;118;118;119;118;119;125;173;159;118;120 12:36:24 INFO - PROCESS | 1663 | |1;audio-beat-detection;149;115;115;147;114;115;115;116;160;145 12:36:24 INFO - PROCESS | 1663 | |2;audio-dft;211;209;213;213;212;213;211;214;210;213 12:36:24 INFO - PROCESS | 1663 | |3;audio-fft;85;62;60;91;65;67;61;61;86;61 12:36:24 INFO - PROCESS | 1663 | |4;audio-oscillator;85;74;127;105;102;71;96;70;71;95 12:36:24 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;91;89;92;88;92;89;92;88;91;90 12:36:24 INFO - PROCESS | 1663 | |6;imaging-darkroom;102;102;102;102;102;101;101;102;102;101 12:36:24 INFO - PROCESS | 1663 | |7;imaging-desaturate;109;99;101;111;99;105;100;100;100;100 12:36:24 INFO - PROCESS | 1663 | |8;json-parse-financial;60;56;55;56;57;59;59;59;59;59 12:36:24 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;70;76;76;84;78;77;76;78;80;79 12:36:24 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;83;84;86;88;86;86;87;86;86;89 12:36:24 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;146;145;146;173;157;163;148;149;251;143 12:36:24 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;169;172;172;173;174;171;171;169;169;172 12:36:24 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;71;70;70;71;69;70;69;69;69;69 12:36:24 INFO - PROCESS | 1663 | __end_tp_report 12:36:24 INFO - PROCESS | 1663 | __start_cc_report 12:36:24 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2080 12:36:24 INFO - PROCESS | 1663 | __end_cc_report 12:36:24 INFO - PROCESS | 1663 | __startTimestamp1478550984689__endTimestamp 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | ------- Summary: start ------- 12:36:24 INFO - PROCESS | 1663 | Number of tests: 14 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:128.70 Median:119.50 stddev:20.04 (16.8%) stddev-sans-first:20.88 12:36:24 INFO - PROCESS | 1663 | Values: 118.0 118.0 119.0 118.0 119.0 125.0 173.0 159.0 118.0 120.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:129.10 Median:130.50 stddev:18.62 (14.3%) stddev-sans-first:18.30 12:36:24 INFO - PROCESS | 1663 | Values: 149.0 115.0 115.0 147.0 114.0 115.0 115.0 116.0 160.0 145.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:211.90 Median:213.00 stddev:1.60 (0.7%) stddev-sans-first:1.66 12:36:24 INFO - PROCESS | 1663 | Values: 211.0 209.0 213.0 213.0 212.0 213.0 211.0 214.0 210.0 213.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:69.90 Median:66.00 stddev:12.31 (18.6%) stddev-sans-first:11.78 12:36:24 INFO - PROCESS | 1663 | Values: 85.0 62.0 60.0 91.0 65.0 67.0 61.0 61.0 86.0 61.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:72.50 stddev:18.86 (26.0%) stddev-sans-first:19.93 12:36:24 INFO - PROCESS | 1663 | Values: 85.0 74.0 127.0 105.0 102.0 71.0 96.0 70.0 71.0 95.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:91.00 stddev:1.62 (1.8%) stddev-sans-first:1.69 12:36:24 INFO - PROCESS | 1663 | Values: 91.0 89.0 92.0 88.0 92.0 89.0 92.0 88.0 91.0 90.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:102.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 12:36:24 INFO - PROCESS | 1663 | Values: 102.0 102.0 102.0 102.0 102.0 101.0 101.0 102.0 102.0 101.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:102.40 Median:107.00 stddev:4.38 (4.1%) stddev-sans-first:3.94 12:36:24 INFO - PROCESS | 1663 | Values: 109.0 99.0 101.0 111.0 99.0 105.0 100.0 100.0 100.0 100.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:59.00 stddev:1.73 (2.9%) stddev-sans-first:1.66 12:36:24 INFO - PROCESS | 1663 | Values: 60.0 56.0 55.0 56.0 57.0 59.0 59.0 59.0 59.0 59.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:77.40 Median:78.00 stddev:3.57 (4.6%) stddev-sans-first:2.59 12:36:24 INFO - PROCESS | 1663 | Values: 70.0 76.0 76.0 84.0 78.0 77.0 76.0 78.0 80.0 79.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:1.73 (2.0%) stddev-sans-first:1.42 12:36:24 INFO - PROCESS | 1663 | Values: 83.0 84.0 86.0 88.0 86.0 86.0 87.0 86.0 86.0 89.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:162.10 Median:153.00 stddev:32.65 (21.3%) stddev-sans-first:34.11 12:36:24 INFO - PROCESS | 1663 | Values: 146.0 145.0 146.0 173.0 157.0 163.0 148.0 149.0 251.0 143.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:172.00 stddev:1.75 (1.0%) stddev-sans-first:1.67 12:36:24 INFO - PROCESS | 1663 | Values: 169.0 172.0 172.0 173.0 174.0 171.0 171.0 169.0 169.0 172.0 12:36:24 INFO - PROCESS | 1663 | 12:36:24 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 12:36:24 INFO - PROCESS | 1663 | Values: 71.0 70.0 70.0 71.0 69.0 70.0 69.0 69.0 69.0 69.0 12:36:24 INFO - PROCESS | 1663 | -------- Summary: end -------- 12:36:24 INFO - PROCESS | 1663 | 12:36:25 INFO - TEST-INFO | 1663: exit 0 12:36:25 INFO - TEST-OK | kraken | took 60757ms 12:36:25 INFO - SUITE-END | took 1178s 12:36:25 INFO - Completed test suite (00:19:38) 12:36:25 INFO - javascript benchmark 12:36:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2885.336372634294, 2897.31913000445, 2901.0426559235448, 2962.377900640864, 2981.731644152026, 4799.208130658441, 4888.535589119028, 4924.80300787968, 4937.629677774168, 4953.900921981558, 4852.175130227861, 4857.854264372066, 4903.926441103386, 4906.582940450066, 4922.6800257983205, 4496.9550304497025, 4526.388937493446, 4570.634349252052, 4573.634109271267, 4606.355110284563, 4408.5591440855815, 4482.574155455227, 4500.987277862471, 4574.771261436931, 4625.8149674013, 4551.408316918796, 4580.450345958489, 4599.034202817395, 4616.1229366420275, 4621.699589526686, 4589.2886602576655, 4609.170349337118, 4619.445666520006, 4620.745858977755, 4629.421322334708, 4500.167469018242, 4503.774811259424, 4505.0, 4517.367568540407, 4579.702319349231, 4890.633202509826, 4898.681585696954, 4980.377452818398, 4986.87532811679, 5008.9499105008845, 5169.896602067937, 5331.653442526223, 5366.436524164946, 5369.463053694639, 5382.515573598395, 5228.529432351069, 5328.387235467932, 5338.679679219259, 5346.705931173784, 5355.6251062425645, 4989.301497790312, 4990.800367985276, 5005.049040682259, 5104.387473503203, 5107.668001579886, 5514.172874068841, 5525.502704756511, 5526.281583394133, 5531.474509921551, 5544.473275038865, 4445.911081778347, 5052.722100284446, 5084.034033533617, 5188.610854185951, 5263.289455923478, 5320.1753728171425, 5389.326334208224, 5389.622726409192, 5395.487428694268, 5422.322209723785, 5325.893482130413, 5329.307190065267, 5342.9465705342445, 5345.412004679482, 5390.245365648812, 5130.204818253177, 5210.947890521046, 5324.6805191687845, 5363.329583802025, 5383.353997520323, 4313.331433627793, 4347.500037495665, 4373.715708478939, 4379.627731642782, 4382.07976324969, 3866.4200369944733, 3951.031997160714, 3959.7822119783114, 3961.623645753649, 3967.988163018412, 4747.430308363018, 4837.274408838632, 4837.37114175155, 4838.975805120952, 4884.755762211875, 5267.841964741064, 5302.09864323066, 5305.920411193835, 5328.147496400557, 5334.546563542142, 4715.0, 4772.7136371817105, 4789.8323558675975, 4811.639127065484, 4823.879403014883, 4009.398590211433, 4645.442546894395, 4709.364235828188, 4719.976400117977, 4809.422869255642, 4581.908361832811, 5636.97181514098, 5637.098064309773, 5646.955313267059, 5646.97176514123, 5390.919136212881, 5406.243125962447, 5442.809501667422, 5447.727613619382, 5466.4260252674485, 5344.572434205332, 5416.404195538409, 5433.483819037185, 5487.862803429946, 5491.670499770026, 4414.9558504414545, 5186.481351864783, 5334.146536554133, 5337.332833395825, 5352.437994010573, 5388.568914486753, 5389.326334208224, 5403.243545903655, 5428.430014848542, 5463.153211252262, 4988.750562471934, 5235.0, 5254.264402983662, 5260.105782017143, 5278.630495865253, 5084.542391184811, 5101.51535604117, 5146.022255771391, 5191.143461328838, 5253.684778913277, 5077.974610127074, 5120.692758434506, 5125.282460455614, 5128.974205158908, 5132.307138536399, 5198.610104242121, 5214.843554693365, 5231.319928409434, 5234.555062819703, 5243.449437808975, 4314.0, 4774.474807771212, 4935.136351138608, 5014.448410674896, 5054.7978080876355], "value": 4902.929070254188, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.35887656379487, 453.2611842696405, 456.39755522709993, 469.58441779025554, 486.67636022045343, 30057.797688092476, 39462.0, 40420.39369409458, 40531.0, 40576.391354129635, 41325.760227193154, 42034.57965420345, 42509.0, 42514.57485425145, 42545.14909701812, 8092.393070519705, 9358.017408172129, 9535.71392858212, 9541.284403669717, 9550.713478595653, 8403.327733781314, 9795.971423000588, 11063.668089957275, 11721.941390293037, 11996.0, 11746.823797643043, 11816.231944923595, 11816.409179541031, 11820.704482387922, 11858.407079646026, 8455.112213217646, 11712.121590880675, 11797.410129493492, 11808.0, 11843.052555795559, 8238.588070596446, 8462.15378462155, 8473.618687159093, 8479.2792612628, 11208.887911120866, 37824.05439863998, 39615.405768913486, 39710.6245969093, 39712.80143599292, 39805.60194398048, 3145.874165033396, 3240.8541615627355, 3343.6154842193214, 3782.375907975181, 3793.2603142387247, 29374.0, 29572.852135739184, 29894.654740536727, 30502.847485762428, 31448.213794655087, 3025.9243518911985, 3163.6519982801874, 3166.6200055993427, 3182.268078341994, 3193.632732235776, 455819.0, 461128.9999999966, 463666.0, 467549.0, 472743.0, 59113.40886591165, 59406.702966485755, 59579.702101489216, 59588.0, 59702.0, 53064.73467632637, 60485.69757151186, 60749.785004299665, 60841.69579152076, 60900.69549652223, 16071.0, 16775.91612041932, 16786.83213167877, 16793.0, 16805.83194168067, 11621.709457263636, 11813.645590632295, 12538.498460061677, 12800.10399272042, 12913.225206487641, 15714.057156570414, 15829.97105188159, 15847.841521584867, 15859.841401586067, 17828.55428614295, 6315.431611155018, 6537.600447767134, 6642.535022548472, 7410.925890741131, 7472.85054298911, 706.2708897023723, 874.5714599846029, 916.2944532709777, 928.071928071928, 972.4408465132577, 28442.573361399594, 29635.407291854473, 29740.0, 30310.69689303123, 30859.537106943415, 940.5532372123187, 959.836827739286, 1012.1599072769584, 1054.435876805905, 1073.8228192348174, 14726.63183420423, 15267.465638702592, 15337.846621533865, 15591.532254032398, 15642.765358519631, 703564.0, 710245.0, 712824.0, 712855.435722818, 713290.0, 48142.75928620405, 49045.019099617806, 55310.0, 56158.71920640452, 56281.0, 1283.948642054326, 1293.8576756556772, 1325.3439547424086, 1326.7280207557235, 1330.4279159961309, 24903.434648343333, 29058.0, 29789.404211915207, 30236.395272093996, 30996.845015774776, 47673.80815479641, 47968.520314796406, 48022.279665804344, 48077.519224808704, 48091.0, 493707.0, 493895.0, 495230.0, 496132.0, 496256.0, 25079.749202508472, 25286.49427011486, 25727.742722573283, 25769.484610307314, 25773.484530309663, 45519.0, 45631.77184114058, 46155.0, 46178.53821461877, 46204.07591848077, 36573.53705851843, 37071.81464092662, 37688.2462350746, 37826.810865945496, 37895.621043790314, 32436.0, 36582.81708591546, 37366.439503406924, 37390.25219495649, 37876.0, 36593.45109823302, 36777.63222367742, 37306.0, 37592.62407375891, 37691.62308376991, 31409.68590314159, 33431.49852752162, 33505.49741753827, 33517.16207094842, 33666.0, 24701.752982470665, 25043.74956250414, 25283.620745689197, 25739.010453379757, 25763.742362576882], "value": 19508.17090321615, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.60162374299716, 323.6116660007991, 340.3652188668134, 352.55225863153794, 372.88813355993193, 14834.629134271649, 15339.616509587251, 15852.52442426729, 17155.914220428913, 19983.90088545133, 19124.713129303072, 20385.98070096493, 20514.897425512852, 21453.892730536325, 21623.243186488475, 5588.720563971795, 6644.235912870034, 6677.232118306384, 6705.932940670604, 6719.260881303053, 6584.93415065848, 6590.967045164767, 6670.0, 6703.6983335749765, 6787.898181527281, 6735.764248251312, 6745.865082698343, 6746.426553742937, 6752.561083529555, 6752.966235168818, 6560.048792925047, 6616.470682345425, 6664.4668426526005, 6699.430548403391, 6785.59286442815, 6238.220222472191, 6498.252700939405, 6539.93460065398, 6549.246836613803, 6563.57336773113, 26497.47005059888, 27695.30761730953, 27878.581821272695, 28294.0, 28598.142055738153, 2424.4181396464724, 2428.2253901441454, 2608.8434693918425, 2738.7124351942957, 3285.8521366538325, 15875.920620396939, 16389.754153687703, 16402.835971640252, 16668.0, 16987.49037528864, 1857.823506766855, 1980.8415326773822, 2006.9197232110698, 2025.422754514956, 2051.7230173926628, 136871.0, 137841.3107934454, 139167.0, 139615.0, 142825.0, 15938.60153496172, 16506.917465412596, 19611.725237859493, 20458.488537786376, 20632.277870274767, 28368.290792730346, 29538.6030606483, 29630.555541666894, 31913.361732765214, 33186.3362732744, 10455.477226138662, 10567.524461399256, 10845.403502807421, 10927.016568508872, 11026.393548354758, 7787.961060194662, 7936.642851071716, 8097.473664211808, 8234.341252699889, 8245.8350832983, 7612.391008719289, 8659.567021648892, 9321.44071355721, 9331.393459425115, 9339.392939458914, 2936.5448355504504, 2947.4252520758246, 3514.7522629466685, 3586.3544561979093, 3604.540161234704, 765.7894079128284, 768.4044865229492, 771.992280077192, 820.6512232301249, 871.5990644303691, 19457.8054219456, 20845.791542084688, 20935.79064209369, 20955.476113097295, 21340.0, 845.1843970568308, 857.6998050682336, 857.811281518065, 858.2876212743408, 879.1120967822418, 10638.787224255471, 10886.564537418415, 10907.890921090688, 10908.127349811995, 10911.018008379284, 558351.0, 580782.0, 581899.0, 594289.0, 596968.0, 129615.0, 134156.0, 135252.0, 135947.0, 139984.0, 855.4653341661461, 943.6084025129632, 971.2278738402987, 973.0707174648194, 974.1086905481405, 17500.82499174992, 18562.257509699462, 19068.618627627093, 19104.235830567177, 19138.425847224604, 54111.45888541064, 55570.0, 56107.43892561022, 56446.0, 56581.0, 75577.24422755922, 77789.61105194438, 78585.60707196427, 79031.20968790469, 80836.5121662217, 7625.6568454418575, 7632.847343052997, 7683.500572462772, 7900.762977110696, 8019.117897031439, 10627.415492148006, 12224.449899754354, 12444.315562644142, 12474.750504989668, 12551.88328197018, 10697.411642359744, 10818.459077045958, 10945.23383363157, 11051.005409513182, 11138.554457821596, 10783.838242426213, 10833.187510936554, 10856.891431085904, 10922.672319830417, 11098.833517497082, 10846.566137354417, 10900.6729798103, 11037.503312351124, 11037.724056898642, 11325.207235493437, 7594.468387212842, 7673.8848917267405, 7883.645235964281, 8064.8790268147195, 8197.77033444988, 9854.802903942025, 10651.147908167482, 10727.463626818784, 10881.966213209733, 10948.233623646269], "value": 10552.304339683056, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1288.8260084888536, 1293.4308904082206, 1313.5008696695254, 1466.6186791434232, 1805.3139806873394, 7544.245575442453, 8091.838163236739, 8350.290225330846, 8592.527410992392, 8596.183362580561, 8471.36464765142, 8577.914220857789, 8585.613647385868, 8592.742217733463, 8597.699080532182, 2254.0645632062715, 2312.930612081632, 2315.9536809263805, 2317.281642690763, 2317.455397981473, 2281.977180228193, 2302.654601809734, 2335.754745751697, 2340.438294809242, 2341.531693661266, 2091.1426315210765, 2196.1983875885267, 2297.540491901618, 2310.9422264443438, 2320.721513418384, 2176.81497072749, 2282.1898226129733, 2296.127471560796, 2301.5166814968875, 2303.2284184798195, 2001.7898120697262, 2265.9320220393415, 2284.805791507724, 2294.0, 2297.689811875409, 8598.0, 8672.739817805475, 8676.52279124648, 8681.435706679109, 8681.739547813575, 5011.824586139468, 5252.501012403815, 5254.553362964152, 5308.654937429054, 5310.0, 3408.352413041514, 3530.75284730069, 3611.693006094485, 3622.5471816022996, 3628.9455658165148, 1046.4715318764052, 1060.4835085827265, 1067.8505009298703, 1071.405370019639, 1073.6564299424188, 11524.539018439253, 11525.596604118899, 11630.94184529072, 11640.417979101096, 11646.767064658745, 4288.807003684779, 4400.977995110004, 4493.348464472699, 4508.436445444319, 4518.254488009507, 8734.475931444134, 8738.781530461789, 8803.471791692518, 8817.691380801642, 8897.065808090187, 5083.034223497598, 5083.822066227738, 5097.821576244888, 5102.0, 5102.158143906288, 4225.598568136023, 4285.892852678708, 4372.672049596293, 4385.342198670225, 4787.569118779326, 3109.875604975776, 3636.636336366342, 3689.723270754704, 3762.097096696773, 3779.3952967525065, 1123.8370436286693, 1129.7966366054188, 1135.0862555642786, 1143.3368646185193, 1167.486306025346, 659.7822718502882, 687.9965600172068, 783.7844592737043, 805.3597390074905, 839.6263662670053, 5413.593980451482, 5590.161475778666, 5687.175359572839, 5758.798442054592, 5785.392533783892, 391.70622033474893, 399.4806751223456, 410.1591736939263, 419.6013786902455, 423.81140392525646, 3785.2997195518365, 3861.5945325740954, 3887.7084218683713, 3902.083010492532, 3908.843646254118, 8814.427062240933, 10118.696439106838, 10530.210234232463, 10538.473076346152, 10539.894601053891, 8904.421212621159, 9842.212622990144, 10321.174306055498, 10326.070653641209, 10487.0, 7612.467127301146, 7716.035495563055, 7726.922730772732, 7840.843183136305, 7845.764627061198, 5743.483086522233, 5791.739371728198, 5805.82582522525, 5862.075856280574, 6034.974054410673, 9696.466694331879, 9857.16214121779, 9869.605215791287, 9872.062154095349, 9878.604855805686, 9071.727848164566, 9886.209103271578, 10049.849252261076, 10148.188144948239, 10189.592416303562, 6744.460443164437, 6958.652067396712, 7115.53749006313, 7246.89129663045, 7340.302671246437, 8024.438289319692, 8026.077001144709, 8068.394870384627, 8131.715389961323, 8138.959305203436, 6153.2000839890525, 7310.9634451829525, 7329.633518324169, 7373.963130184315, 7395.445341599294, 7067.57594544329, 7195.2085270619145, 7204.53170543913, 7218.783436496913, 7249.891251631335, 6767.661616919036, 6902.171739391305, 6908.930910690829, 6915.930840691529, 6916.273791251846, 4785.880352991064, 4789.744663247568, 4906.705597664151, 4936.160852655129, 5051.62112841531, 4062.9390559141048, 4838.830640927551, 4875.585575226146, 4882.7314497701545, 5049.949500505095], "value": 4295.987540936033, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.630716457706, 270.77525653707426, 280.2098083404798, 281.6999895111706, 285.14030198950155, 3250.4961730931686, 3604.4773507841346, 4083.8162282697276, 4101.241270364984, 4132.607402296777, 3872.341701910675, 4002.879913602589, 4023.657989070925, 4064.4106604542326, 4076.9592304077023, 3233.6604656510963, 3255.251292202795, 3266.2035880265876, 3270.771046026779, 3281.983590082058, 2678.866056697167, 2824.4209936962975, 3268.9019329420157, 3286.622038465571, 3315.6293250326135, 2947.233719233004, 3011.6988301169927, 3181.9499565143565, 3190.6649801770827, 3252.1544398456454, 3203.6475987641343, 3210.5344725014743, 3220.983895080533, 3221.307418904935, 3247.967520324802, 2840.957385639217, 2848.3875966667265, 2856.8000239983207, 2859.4567032263803, 2878.553824157238, 3536.885880947493, 3628.872989445357, 3914.256291304643, 3930.5872883347124, 3943.2902077626018, 3111.9222019449467, 3376.898693039213, 3632.5096112024803, 3643.6174201708704, 3687.1703866630064, 4343.956560434387, 4351.26028575143, 4373.332267316934, 4381.737095774264, 4382.8904277393, 3131.5302704594264, 3146.197719581515, 3146.9615027041023, 3147.3547922676025, 3170.8573114209917, 3821.1211421372964, 4444.0, 4464.821407143743, 4468.4637843458995, 4504.459464864204, 2677.942212825923, 2768.7784977201777, 2881.3516958684127, 3160.2099475131217, 3222.564953731216, 2450.277168235375, 3160.6365267994474, 3310.354480876206, 3339.666033396641, 3341.396129857682, 3314.3537010283244, 3537.4163263061305, 3696.852125914987, 3712.406015037581, 3766.6610005099674, 4394.428724265889, 4432.778361081933, 4433.290673492225, 4438.716638443917, 4484.932726009112, 1067.3275836223129, 1082.24783775277, 1084.2356138922041, 1098.6154845803906, 1110.666799960025, 622.7166639179162, 703.1702590942634, 727.5961841178091, 778.2256654628568, 809.4414853750893, 3874.9612503875164, 3902.492675952108, 3950.7827069511454, 3982.721209515364, 4007.3369551635747, 4359.542248063971, 4422.827950593095, 4475.149721552894, 4567.223571992769, 4578.88552786183, 3789.5642001169667, 3853.6917046636204, 4023.3361495352938, 4033.616806403387, 4114.465119534441, 1766.8498177655044, 1958.8452702027655, 2168.7421295648487, 2331.661909023182, 2388.8686122263443, 4580.4045474088825, 4587.669575822974, 4588.036512332447, 4654.581087702055, 4789.700943547047, 3793.867214647474, 4468.6931670563545, 4539.568740969603, 4541.02367990877, 4577.496475387705, 3561.8397172127316, 3839.9424008639894, 4373.934390984138, 4602.470715867718, 4614.907701845877, 3712.6287371262656, 4536.5236650151255, 4579.38178345919, 4604.861854144381, 4629.0, 4413.955860441483, 4416.271315232951, 4423.513413524445, 4427.80074896624, 4549.385832912514, 4172.70791044624, 4479.148961697267, 4596.3105534170145, 4658.487566367765, 4750.904981900274, 2674.2378422150373, 3170.3659268146926, 3198.248411623313, 3210.727088197529, 3215.5658986036588, 4118.485189351331, 4478.328250762412, 4493.101379724003, 4510.1656193604285, 4512.0, 4188.910473774379, 4410.536893626123, 4433.674743942043, 4440.956375251878, 4449.9542607487865, 3629.2560025194243, 3939.3500072488864, 4387.8315600180595, 4413.40419043425, 4425.871402792396, 3651.214988777426, 4315.187621199041, 4329.76186309756, 4331.956680433155, 4334.1981733379425, 3520.647935206561, 4223.472065991751, 4313.266744653479, 4323.805428755651, 4361.0, 3686.594474607845, 3935.9103104063174, 4165.687573431944, 4431.689781715378, 4458.598726114666], "value": 3235.835791419226, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.807964730052, 723.1900271695702, 723.7828651404578, 728.6757392960131, 750.7109762741343, 14428.35072421741, 15552.300146493406, 15571.68856622867, 15623.921880390597, 15675.60810979726, 13965.650858728537, 14137.151770893754, 14148.50480233192, 14154.858451415483, 14198.219097949608, 645.3578689204224, 667.6995352091554, 669.7622344067859, 801.1667865419971, 802.1577343789028, 822.2065706593137, 824.1140773668301, 836.0051538668964, 837.3092198935872, 838.4801423117675, 875.1685898396516, 889.1064480197392, 894.0523045571682, 894.3247847874845, 896.6771962093641, 669.5012215899186, 689.018149137482, 888.7511496780912, 891.572045418203, 892.6340200517789, 627.2410383436048, 641.6727468990802, 643.9710213040424, 648.5298158834808, 650.1710319342828, 14654.340554675066, 14681.0, 14693.632659183499, 14693.632659183499, 14726.190059546721, 13217.73564528704, 13307.135036222615, 13443.32783360828, 13627.869993042461, 14049.859501404957, 8375.41372103953, 10733.0, 10806.243562950596, 11494.88505114955, 11740.941295293555, 4263.914721705549, 4284.464441944757, 4361.760103194323, 4642.396488456513, 4652.395188625457, 95092.0, 97329.5133524335, 98633.0136698631, 104363.0, 106735.46632266867, 10121.898781012243, 10290.073893349634, 10401.375917444977, 10474.633387831389, 10805.621803236849, 19616.509587260432, 19785.60428791416, 19825.900870495556, 19830.305939292055, 19834.50413739668, 7507.624618769039, 7596.050493688289, 7619.771406857803, 7701.884471732928, 7714.884276735854, 4154.459920210354, 4203.306454435045, 4225.915481690349, 4268.146370725867, 4273.722208056466, 3242.8702851886133, 3723.1622884851236, 3874.1089549403796, 3914.8042597869994, 3946.5856085111222, 700.7617410080597, 701.1901254051579, 704.7744721689011, 709.0888208651858, 719.9928000720031, 519.7037688517509, 546.4562760053772, 613.0130489911239, 614.620177701064, 621.7450845153465, 8594.613242404106, 8807.69173078952, 9265.119813617695, 9387.906120938704, 9514.38156519824, 464.85120301310667, 471.75468756247244, 534.4228233507803, 552.3013388064102, 613.5183880653666, 4105.568915263854, 4470.585903432994, 4475.70907890986, 4596.034832685106, 4618.538146185422, 126672.36663816807, 130437.0, 132241.33879330542, 142564.0, 143437.28281358734, 92721.0, 107441.46279268553, 109110.0, 111128.4443577777, 114680.0, 71467.0, 97315.0, 104760.47619761853, 105117.0, 106580.0, 7661.693532258871, 9593.90406095958, 9616.23070154372, 9681.612735490502, 9755.0, 45464.54535454603, 55596.0, 57931.0, 58315.708421457624, 59729.701351492964, 86888.56555717181, 90304.08088841291, 90757.18485630119, 92252.0, 96656.0, 12540.623781286577, 12617.873821262037, 12680.302583358003, 13068.934655327042, 13081.7183832725, 13683.384247709077, 13918.51285205013, 13986.230757308038, 14580.927095364455, 15423.228838558252, 11910.344931028876, 13608.251546165056, 13742.793858091936, 13769.0, 13879.167249965034, 13034.674133146747, 13225.603231903058, 13666.794998075236, 13973.720525589635, 14452.843772498385, 13101.672458188621, 13800.03399762007, 13898.23559704226, 13999.16005039701, 14012.859871401562, 9729.367591106555, 10179.949100254747, 10200.3369780964, 10501.789964200825, 11161.72095697614, 9073.637054517745, 10921.78156436851, 11184.273022253528, 11269.380184089627, 11335.773284534429], "value": 7490.156256997577, "unit": "score"}], "name": "dromaeo_css", "value": 6869.697779002964, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 119.0, 125.0, 173.0, 159.0, 118.0, 120.0], "value": 128.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 115.0, 115.0, 147.0, 114.0, 115.0, 115.0, 116.0, 160.0, 145.0], "value": 129.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 209.0, 213.0, 213.0, 212.0, 213.0, 211.0, 214.0, 210.0, 213.0], "value": 211.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 62.0, 60.0, 91.0, 65.0, 67.0, 61.0, 61.0, 86.0, 61.0], "value": 69.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 74.0, 127.0, 105.0, 102.0, 71.0, 96.0, 70.0, 71.0, 95.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 92.0, 88.0, 92.0, 89.0, 92.0, 88.0, 91.0, 90.0], "value": 90.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 102.0, 102.0, 102.0, 102.0, 101.0, 101.0, 102.0, 102.0, 101.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 99.0, 101.0, 111.0, 99.0, 105.0, 100.0, 100.0, 100.0, 100.0], "value": 102.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 56.0, 55.0, 56.0, 57.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 76.0, 84.0, 78.0, 77.0, 76.0, 78.0, 80.0, 79.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 86.0, 88.0, 86.0, 86.0, 87.0, 86.0, 86.0, 89.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 173.0, 157.0, 163.0, 148.0, 149.0, 251.0, 143.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 172.0, 173.0, 174.0, 171.0, 171.0, 169.0, 169.0, 172.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 71.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1547.8999999999999, "alertThreshold": 2.0}]} 12:36:25 INFO - Return code: 0 12:36:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:36:26 INFO - # TBPL SUCCESS # 12:36:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:36:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:36:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:36:26 INFO - 2016-11-07 12:36:26.047 screenresolution[1667:11186] starting screenresolution argv=screenresolution get 12:36:26 INFO - 2016-11-07 12:36:26.050 screenresolution[1667:11186] Display 0: 1600x1200x32@60 12:36:26 INFO - 2016-11-07 12:36:26.056 screenresolution[1668:11189] starting screenresolution argv=screenresolution list 12:36:26 INFO - Available Modes on Display 0 12:36:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:36:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:36:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:36:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:36:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:36:26 INFO - Intel Iris: 12:36:26 INFO - Chipset Model: Intel Iris 12:36:26 INFO - Type: GPU 12:36:26 INFO - Bus: Built-In 12:36:26 INFO - VRAM (Dynamic, Max): 1536 MB 12:36:26 INFO - Vendor: Intel (0x8086) 12:36:26 INFO - Device ID: 0x0a2e 12:36:26 INFO - Revision ID: 0x0009 12:36:26 INFO - Displays: 12:36:26 INFO - Display: 12:36:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:36:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:36:26 INFO - Display Serial Number: 1600x1200 60 12:36:26 INFO - Main Display: Yes 12:36:26 INFO - Mirror: Off 12:36:26 INFO - Online: Yes 12:36:26 INFO - Rotation: Supported 12:36:26 INFO - Return code: 0 12:36:26 INFO - Running post-action listener: _resource_record_post_action 12:36:26 INFO - [mozharness: 2016-11-07 20:36:26.298720Z] Finished run-tests step (success) 12:36:26 INFO - Running post-run listener: _resource_record_post_run 12:36:26 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 32521216; Write bytes: 664663552; Read time: 317; Write time: 1848 12:36:26 INFO - TinderboxPrint: CPU usage
53.3% 12:36:26 INFO - TinderboxPrint: I/O read bytes / time
32,521,216 / 317 12:36:26 INFO - TinderboxPrint: I/O write bytes / time
664,663,552 / 1,848 12:36:26 INFO - TinderboxPrint: CPU idle
2,265.1 (46.7%) 12:36:26 INFO - TinderboxPrint: CPU system
972.3 (20.0%) 12:36:26 INFO - TinderboxPrint: CPU user
1,616.3 (33.3%) 12:36:26 INFO - TinderboxPrint: Swap in / out
391,843,840 / 0 12:36:26 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 364425728; Write bytes: 357639680; Read time: 29389; Write time: 671 12:36:26 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 29228032; Write bytes: 296595456; Read time: 291; Write time: 1141 12:36:26 INFO - Running post-run listener: _upload_blobber_files 12:36:26 INFO - Blob upload gear active. 12:36:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:36:26 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 12:36:26 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:36:26 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:36:27 INFO - (blobuploader) - INFO - Open directory for files ... 12:36:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:36:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:36:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:27 INFO - (blobuploader) - INFO - Done attempting. 12:36:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:36:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:36:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:28 INFO - (blobuploader) - INFO - Done attempting. 12:36:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:36:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:36:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:31 INFO - (blobuploader) - INFO - Done attempting. 12:36:31 INFO - (blobuploader) - INFO - Iteration through files over. 12:36:31 INFO - Return code: 0 12:36:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:36:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:36:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40f30128905d436be9a6f0a1a84f58d404fd6ee655d4ff383b4ad5fb46198e8ccafe6d19de9dcb38206743936f7e7f5c01e5617775e789c54b67cdb1a1fc6392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bd6175cd0ebf2710f46695696fb295eda99050d810328f0fda72b9bbbf38f006858284c64ca8cf64c798d50e3eebc0d5b78d46c4e8a49497b3b599428a22646", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bce0e41b37c633bb83f1fc26d71051c7807665881c5c44ea3530005914efb57cf6ecb04231101c997066c5bd8454706adc70420b44e34a6807e094f27cec50d"} 12:36:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:36:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:36:31 INFO - Contents: 12:36:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40f30128905d436be9a6f0a1a84f58d404fd6ee655d4ff383b4ad5fb46198e8ccafe6d19de9dcb38206743936f7e7f5c01e5617775e789c54b67cdb1a1fc6392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bd6175cd0ebf2710f46695696fb295eda99050d810328f0fda72b9bbbf38f006858284c64ca8cf64c798d50e3eebc0d5b78d46c4e8a49497b3b599428a22646", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bce0e41b37c633bb83f1fc26d71051c7807665881c5c44ea3530005914efb57cf6ecb04231101c997066c5bd8454706adc70420b44e34a6807e094f27cec50d"} 12:36:31 INFO - Running post-run listener: copy_logs_to_upload_dir 12:36:31 INFO - Copying logs to upload dir... 12:36:31 INFO - mkdir: /builds/slave/test/build/upload/logs 12:36:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.807835 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-11-07 12:36:31.443987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 12:36:31.448055) ========= 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.W71TYprGmo/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.KmPZhOsAA1/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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/Mozilla-Aurora/sha512/40f30128905d436be9a6f0a1a84f58d404fd6ee655d4ff383b4ad5fb46198e8ccafe6d19de9dcb38206743936f7e7f5c01e5617775e789c54b67cdb1a1fc6392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bd6175cd0ebf2710f46695696fb295eda99050d810328f0fda72b9bbbf38f006858284c64ca8cf64c798d50e3eebc0d5b78d46c4e8a49497b3b599428a22646", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bce0e41b37c633bb83f1fc26d71051c7807665881c5c44ea3530005914efb57cf6ecb04231101c997066c5bd8454706adc70420b44e34a6807e094f27cec50d"} build_url:https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011844 build_url: 'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/40f30128905d436be9a6f0a1a84f58d404fd6ee655d4ff383b4ad5fb46198e8ccafe6d19de9dcb38206743936f7e7f5c01e5617775e789c54b67cdb1a1fc6392", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bd6175cd0ebf2710f46695696fb295eda99050d810328f0fda72b9bbbf38f006858284c64ca8cf64c798d50e3eebc0d5b78d46c4e8a49497b3b599428a22646", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3bce0e41b37c633bb83f1fc26d71051c7807665881c5c44ea3530005914efb57cf6ecb04231101c997066c5bd8454706adc70420b44e34a6807e094f27cec50d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 12:36:31.481580) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:36:31.481909) ========= 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.W71TYprGmo/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.KmPZhOsAA1/Listeners TMPDIR=/var/folders/nm/9455zyq90cx5b0vslr6bbx7h00000w/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.005431 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:36:31.532331) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 12:36:31.532667) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 12:36:31.533476) ========= ========= Total master_lag: 0.17 =========