builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0311 starttime: 1475163627.18 results: success (0) buildid: 20160929070429 builduid: 73134300eb2a4975a43a2fc855d855e7 revision: 25c9e1f272a79d4000ce1b3ea4b909fdfbd95ece ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:27.176310) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:27.176705) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:27.177010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:27.200523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:27.200817) ========= 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.GGFcorvvrb/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.evHZCqPLFH/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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-09-29 08:40:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2016-09-29 08:40:27 (18.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109646 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:27.335272) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:27.335696) ========= 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.GGFcorvvrb/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.evHZCqPLFH/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.026649 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:27.385782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 08:40:27.386179) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 25c9e1f272a79d4000ce1b3ea4b909fdfbd95ece --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 25c9e1f272a79d4000ce1b3ea4b909fdfbd95ece --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GGFcorvvrb/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.evHZCqPLFH/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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-09-29 08:40:27,468 truncating revision to first 12 chars 2016-09-29 08:40:27,468 Setting DEBUG logging. 2016-09-29 08:40:27,468 attempt 1/10 2016-09-29 08:40:27,468 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/25c9e1f272a7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 08:40:28,454 unpacking tar archive at: mozilla-aurora-25c9e1f272a7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.267407 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-29 08:40:28.674831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:28.675176) ========= script_repo_revision: 25c9e1f272a79d4000ce1b3ea4b909fdfbd95ece ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:28.675550) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:28.675826) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 08:40:28.693495) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-29 08:40:28.693760) ========= /tools/buildbot/bin/python 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', '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.GGFcorvvrb/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.evHZCqPLFH/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:40:28 INFO - MultiFileLogger online at 20160929 08:40:28 in /builds/slave/test 08:40:28 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 08:40:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:28 INFO - {'append_to_log': False, 08:40:28 INFO - 'base_work_dir': '/builds/slave/test', 08:40:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:40:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:28 INFO - 'branch': 'Mozilla-Aurora', 08:40:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:28 INFO - 'config_files': ('talos/mac_config.py',), 08:40:28 INFO - 'default_actions': ('clobber', 08:40:28 INFO - 'read-buildbot-config', 08:40:28 INFO - 'download-and-extract', 08:40:28 INFO - 'populate-webroot', 08:40:28 INFO - 'create-virtualenv', 08:40:28 INFO - 'install', 08:40:28 INFO - 'run-tests'), 08:40:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:28 INFO - 'download_minidump_stackwalk': True, 08:40:28 INFO - 'download_symbols': 'ondemand', 08:40:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:28 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:28 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:28 INFO - 'installer_path': 'installer.exe', 08:40:28 INFO - 'log_level': 'info', 08:40:28 INFO - 'log_name': 'talos', 08:40:28 INFO - 'log_to_console': True, 08:40:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:40:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:40:28 INFO - 'opt_config_files': (), 08:40:28 INFO - 'pip_index': False, 08:40:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:28 INFO - 'cmd': ('bash', 08:40:28 INFO - '-c', 08:40:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:28 INFO - 'enabled': True, 08:40:28 INFO - 'halt_on_failure': False, 08:40:28 INFO - 'name': 'check_screen_resolution'},), 08:40:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:28 INFO - 'cmd': ('bash', 08:40:28 INFO - '-c', 08:40:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:28 INFO - 'enabled': True, 08:40:28 INFO - 'halt_on_failure': False, 08:40:28 INFO - 'name': 'check_screen_resolution'},), 08:40:28 INFO - 'run_cmd_checks_enabled': True, 08:40:28 INFO - 'sps_profile': False, 08:40:28 INFO - 'sps_profile_interval': 0, 08:40:28 INFO - 'suite': 'dromaeojs', 08:40:28 INFO - 'system_bits': '32', 08:40:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:28 INFO - 'title': 't-yosemite-r7-0311', 08:40:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:28 INFO - 'use_talos_json': True, 08:40:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:28 INFO - 'work_dir': 'build'} 08:40:28 INFO - [mozharness: 2016-09-29 15:40:28.890321Z] Running clobber step. 08:40:28 INFO - Running pre-action listener: _resource_record_pre_action 08:40:28 INFO - Running main action method: clobber 08:40:28 INFO - rmtree: /builds/slave/test/build 08:40:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:30 INFO - Running post-action listener: _resource_record_post_action 08:40:30 INFO - [mozharness: 2016-09-29 15:40:30.978997Z] Finished clobber step (success) 08:40:30 INFO - [mozharness: 2016-09-29 15:40:30.979123Z] Running read-buildbot-config step. 08:40:30 INFO - Running pre-action listener: _resource_record_pre_action 08:40:30 INFO - Running main action method: read_buildbot_config 08:40:30 INFO - Using buildbot properties: 08:40:30 INFO - { 08:40:30 INFO - "project": "", 08:40:30 INFO - "product": "firefox", 08:40:30 INFO - "script_repo_revision": "production", 08:40:30 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:40:30 INFO - "repository": "", 08:40:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:40:30 INFO - "buildid": "20160929070429", 08:40:30 INFO - "pgo_build": "False", 08:40:30 INFO - "basedir": "/builds/slave/test", 08:40:30 INFO - "buildnumber": 23, 08:40:30 INFO - "slavename": "t-yosemite-r7-0311", 08:40:30 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:40:30 INFO - "platform": "yosemite_r7", 08:40:30 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:40:30 INFO - "branch": "mozilla-aurora", 08:40:30 INFO - "repo_path": "releases/mozilla-aurora", 08:40:30 INFO - "revision": "25c9e1f272a79d4000ce1b3ea4b909fdfbd95ece", 08:40:30 INFO - "stage_platform": "macosx64", 08:40:30 INFO - "builduid": "73134300eb2a4975a43a2fc855d855e7", 08:40:30 INFO - "slavebuilddir": "test" 08:40:30 INFO - } 08:40:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 08:40:30 INFO - Running post-action listener: _resource_record_post_action 08:40:30 INFO - [mozharness: 2016-09-29 15:40:30.982947Z] Finished read-buildbot-config step (success) 08:40:30 INFO - [mozharness: 2016-09-29 15:40:30.983122Z] Running download-and-extract step. 08:40:30 INFO - Running pre-action listener: _resource_record_pre_action 08:40:30 INFO - Running main action method: download_and_extract 08:40:30 INFO - mkdir: /builds/slave/test/build/tests 08:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:30 INFO - trying https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 08:40:30 INFO - Downloading https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/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 08:40:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/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 08:40:31 INFO - Downloaded 1199 bytes. 08:40:31 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 08:40:31 INFO - Using the following test package requirements: 08:40:31 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:40:31 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:40:31 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 08:40:31 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:40:31 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 08:40:31 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:40:31 INFO - u'jsshell-mac.zip'], 08:40:31 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:40:31 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 08:40:31 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 08:40:31 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:40:31 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 08:40:31 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:40:31 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 08:40:31 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:40:31 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 08:40:31 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 08:40:31 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 08:40:31 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:40:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:40:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:40:31 INFO - Fetch https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:40:32 INFO - Expected file size: 16432363 08:40:39 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 08:40:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 08:40:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:40:39 INFO - Fetch https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 08:40:39 INFO - Expected file size: 16432363 08:40:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 08:40:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:40:46 INFO - Fetch https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 08:40:47 INFO - Expected file size: 14414059 08:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:48 INFO - trying https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:40:48 INFO - Downloading https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 08:40:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/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 08:40:51 INFO - Downloaded 115275939 bytes. 08:40:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:40:51 INFO - mkdir: /builds/slave/test/properties 08:40:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:51 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:51 INFO - Contents: 08:40:51 INFO - build_url:https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 08:40:51 INFO - Running post-action listener: _resource_record_post_action 08:40:51 INFO - Running post-action listener: set_extra_try_arguments 08:40:51 INFO - [mozharness: 2016-09-29 15:40:51.772377Z] Finished download-and-extract step (success) 08:40:51 INFO - [mozharness: 2016-09-29 15:40:51.772497Z] Running populate-webroot step. 08:40:51 INFO - Running pre-action listener: _resource_record_pre_action 08:40:51 INFO - Running main action method: populate_webroot 08:40:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:51 INFO - '--tppagecycles', 08:40:51 INFO - '7'], 08:40:51 INFO - 'tests': ['tsvgm']}}, 08:40:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:51 INFO - 'talos_options': ['--disable-e10s'], 08:40:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:51 INFO - 'talos_options': ['--disable-e10s'], 08:40:51 INFO - 'tests': ['damp', 'tps']}, 08:40:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:51 INFO - 'tests': ['damp', 'tps']}, 08:40:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:51 INFO - 'tests': ['dromaeo_dom']}, 08:40:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:51 INFO - 'tests': ['basic_compositor_video']}, 08:40:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:51 INFO - 'tests': ['a11yr', 08:40:51 INFO - 'ts_paint', 08:40:51 INFO - 'tpaint', 08:40:51 INFO - 'sessionrestore', 08:40:51 INFO - 'sessionrestore_no_auto_restore', 08:40:51 INFO - 'tabpaint']}, 08:40:51 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:51 INFO - 'ts_paint', 08:40:51 INFO - 'tpaint', 08:40:51 INFO - 'sessionrestore', 08:40:51 INFO - 'sessionrestore_no_auto_restore', 08:40:51 INFO - 'tabpaint']}, 08:40:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:51 INFO - 'ts_paint', 08:40:51 INFO - 'tpaint', 08:40:51 INFO - 'sessionrestore', 08:40:51 INFO - 'sessionrestore_no_auto_restore', 08:40:51 INFO - 'tabpaint']}, 08:40:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:51 INFO - 'ts_paint', 08:40:51 INFO - 'tpaint', 08:40:51 INFO - 'sessionrestore', 08:40:51 INFO - 'sessionrestore_no_auto_restore', 08:40:51 INFO - 'tabpaint']}, 08:40:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:51 INFO - 'tests': ['a11yr', 08:40:51 INFO - 'ts_paint', 08:40:51 INFO - 'tpaint', 08:40:51 INFO - 'sessionrestore', 08:40:51 INFO - 'sessionrestore_no_auto_restore', 08:40:51 INFO - 'tabpaint']}, 08:40:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:51 INFO - 'tests': ['a11yr', 08:40:51 INFO - 'ts_paint', 08:40:51 INFO - 'tpaint', 08:40:51 INFO - 'sessionrestore', 08:40:51 INFO - 'sessionrestore_no_auto_restore', 08:40:51 INFO - 'tabpaint']}, 08:40:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:51 INFO - 'tests': ['tsvgx', 08:40:51 INFO - 'tsvgr_opacity', 08:40:51 INFO - 'tart', 08:40:51 INFO - 'tscrollx', 08:40:51 INFO - 'cart']}, 08:40:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:51 INFO - 'tsvgr_opacity', 08:40:51 INFO - 'tart', 08:40:51 INFO - 'tscrollx', 08:40:51 INFO - 'cart']}, 08:40:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:51 INFO - 'talos_options': ['--disable-e10s'], 08:40:51 INFO - 'tests': ['tp5o']}, 08:40:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:51 INFO - 'tests': ['tp5o']}, 08:40:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:51 INFO - 'talos_options': ['--disable-e10s', 08:40:51 INFO - '--xperf_path', 08:40:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:51 INFO - 'tests': ['tp5n']}, 08:40:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:51 INFO - 'talos_options': ['--xperf_path', 08:40:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:51 INFO - 'tests': ['tp5n']}}, 08:40:51 INFO - 'talos.zip': {'path': '', 08:40:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:51 INFO - Running post-action listener: _resource_record_post_action 08:40:51 INFO - [mozharness: 2016-09-29 15:40:51.791260Z] Finished populate-webroot step (success) 08:40:51 INFO - [mozharness: 2016-09-29 15:40:51.791366Z] Running create-virtualenv step. 08:40:51 INFO - Running pre-action listener: _resource_record_pre_action 08:40:51 INFO - Running main action method: create_virtualenv 08:40:51 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:40:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:51 INFO - Using real prefix '/tools/python27' 08:40:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:52 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:55 INFO - Installing pip.................done. 08:40:55 INFO - Return code: 0 08:40:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 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 0x10b1b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b12d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddc2ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afcbd30>, '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 0x10ae31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afc3b20>, '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.GGFcorvvrb/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.evHZCqPLFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:40:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GGFcorvvrb/Render', 08:40:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:55 INFO - 'HOME': '/Users/cltbld', 08:40:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:55 INFO - 'LOGNAME': 'cltbld', 08:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:55 INFO - 'MOZ_NO_REMOTE': '1', 08:40:55 INFO - 'NO_EM_RESTART': '1', 08:40:55 INFO - 'PAGER': '/bin/cat', 08:40:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:55 INFO - 'PWD': '/builds/slave/test', 08:40:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:55 INFO - 'SHELL': '/bin/bash', 08:40:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.evHZCqPLFH/Listeners', 08:40:55 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 08:40:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:55 INFO - 'USER': 'cltbld', 08:40:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:55 INFO - 'XPC_FLAGS': '0x0', 08:40:55 INFO - 'XPC_SERVICE_NAME': '0', 08:40:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:40:55 INFO - Cleaning up... 08:40:55 INFO - Return code: 0 08:40:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:55 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 0x10b1b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b12d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddc2ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afcbd30>, '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 0x10ae31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afc3b20>, '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.GGFcorvvrb/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.evHZCqPLFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:40:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:40:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:40:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GGFcorvvrb/Render', 08:40:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:55 INFO - 'HOME': '/Users/cltbld', 08:40:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:55 INFO - 'LOGNAME': 'cltbld', 08:40:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:55 INFO - 'MOZ_NO_REMOTE': '1', 08:40:55 INFO - 'NO_EM_RESTART': '1', 08:40:55 INFO - 'PAGER': '/bin/cat', 08:40:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:55 INFO - 'PWD': '/builds/slave/test', 08:40:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:55 INFO - 'SHELL': '/bin/bash', 08:40:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.evHZCqPLFH/Listeners', 08:40:55 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 08:40:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:55 INFO - 'USER': 'cltbld', 08:40:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:55 INFO - 'XPC_FLAGS': '0x0', 08:40:55 INFO - 'XPC_SERVICE_NAME': '0', 08:40:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:56 INFO - Downloading/unpacking psutil>=3.1.1 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40: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 08:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:59 INFO - Installing collected packages: psutil 08:40:59 INFO - Running setup.py install for psutil 08:40:59 INFO - building 'psutil._psutil_osx' extension 08:40:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:40:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:40:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:41:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:41:00 INFO - building 'psutil._psutil_posix' extension 08:41:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:41:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:41:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:41:00 INFO - ^ 08:41:00 INFO - 1 warning generated. 08:41:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:41:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:00 INFO - Successfully installed psutil 08:41:00 INFO - Cleaning up... 08:41:00 INFO - Return code: 0 08:41:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:00 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 0x10b1b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b12d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddc2ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afcbd30>, '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 0x10ae31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afc3b20>, '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.GGFcorvvrb/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.evHZCqPLFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:41:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GGFcorvvrb/Render', 08:41:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:00 INFO - 'HOME': '/Users/cltbld', 08:41:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:00 INFO - 'LOGNAME': 'cltbld', 08:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:00 INFO - 'MOZ_NO_REMOTE': '1', 08:41:00 INFO - 'NO_EM_RESTART': '1', 08:41:00 INFO - 'PAGER': '/bin/cat', 08:41:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:00 INFO - 'PWD': '/builds/slave/test', 08:41:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:00 INFO - 'SHELL': '/bin/bash', 08:41:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.evHZCqPLFH/Listeners', 08:41:00 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 08:41:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:00 INFO - 'USER': 'cltbld', 08:41:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:00 INFO - 'XPC_FLAGS': '0x0', 08:41:00 INFO - 'XPC_SERVICE_NAME': '0', 08:41:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:41:03 INFO - Installing collected packages: mozsystemmonitor 08:41:03 INFO - Running setup.py install for mozsystemmonitor 08:41:03 INFO - Successfully installed mozsystemmonitor 08:41:03 INFO - Cleaning up... 08:41:03 INFO - Return code: 0 08:41:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:03 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 0x10b1b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b12d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddc2ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afcbd30>, '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 0x10ae31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afc3b20>, '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.GGFcorvvrb/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.evHZCqPLFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:41:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GGFcorvvrb/Render', 08:41:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:03 INFO - 'HOME': '/Users/cltbld', 08:41:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:03 INFO - 'LOGNAME': 'cltbld', 08:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:03 INFO - 'MOZ_NO_REMOTE': '1', 08:41:03 INFO - 'NO_EM_RESTART': '1', 08:41:03 INFO - 'PAGER': '/bin/cat', 08:41:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:03 INFO - 'PWD': '/builds/slave/test', 08:41:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:03 INFO - 'SHELL': '/bin/bash', 08:41:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.evHZCqPLFH/Listeners', 08:41:03 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 08:41:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:03 INFO - 'USER': 'cltbld', 08:41:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:03 INFO - 'XPC_FLAGS': '0x0', 08:41:03 INFO - 'XPC_SERVICE_NAME': '0', 08:41:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:03 INFO - Downloading/unpacking jsonschema==2.5.1 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:07 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:07 INFO - warning: no files found matching '*.txt' 08:41:07 INFO - no previously-included directories found matching 'build' 08:41:07 INFO - no previously-included directories found matching 'dist' 08:41:07 INFO - no previously-included directories found matching '.git*' 08:41:07 INFO - Installing collected packages: jsonschema, functools32 08:41:07 INFO - Running setup.py install for functools32 08:41:07 INFO - warning: no files found matching '*.txt' 08:41:07 INFO - no previously-included directories found matching 'build' 08:41:07 INFO - no previously-included directories found matching 'dist' 08:41:07 INFO - no previously-included directories found matching '.git*' 08:41:07 INFO - Successfully installed jsonschema functools32 08:41:07 INFO - Cleaning up... 08:41:07 INFO - Return code: 0 08:41:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b1b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b12d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddc2ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afcbd30>, '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 0x10ae31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afc3b20>, '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.GGFcorvvrb/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.evHZCqPLFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GGFcorvvrb/Render', 08:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:07 INFO - 'HOME': '/Users/cltbld', 08:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:07 INFO - 'LOGNAME': 'cltbld', 08:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:07 INFO - 'MOZ_NO_REMOTE': '1', 08:41:07 INFO - 'NO_EM_RESTART': '1', 08:41:07 INFO - 'PAGER': '/bin/cat', 08:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:07 INFO - 'PWD': '/builds/slave/test', 08:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:07 INFO - 'SHELL': '/bin/bash', 08:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.evHZCqPLFH/Listeners', 08:41:07 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 08:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:07 INFO - 'USER': 'cltbld', 08:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:07 INFO - 'XPC_FLAGS': '0x0', 08:41:07 INFO - 'XPC_SERVICE_NAME': '0', 08:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:41:08 INFO - Cleaning up... 08:41:08 INFO - Return code: 0 08:41:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:08 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 0x10b1b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b12d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddc2ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afcbd30>, '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 0x10ae31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afc3b20>, '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.GGFcorvvrb/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.evHZCqPLFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GGFcorvvrb/Render', 08:41:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:08 INFO - 'HOME': '/Users/cltbld', 08:41:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:08 INFO - 'LOGNAME': 'cltbld', 08:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:08 INFO - 'MOZ_NO_REMOTE': '1', 08:41:08 INFO - 'NO_EM_RESTART': '1', 08:41:08 INFO - 'PAGER': '/bin/cat', 08:41:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:08 INFO - 'PWD': '/builds/slave/test', 08:41:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:08 INFO - 'SHELL': '/bin/bash', 08:41:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.evHZCqPLFH/Listeners', 08:41:08 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 08:41:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:08 INFO - 'USER': 'cltbld', 08:41:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:08 INFO - 'XPC_FLAGS': '0x0', 08:41:08 INFO - 'XPC_SERVICE_NAME': '0', 08:41:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:08 INFO - Downloading/unpacking blobuploader==1.2.4 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41: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 08:41:10 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:12 INFO - Downloading docopt-0.6.1.tar.gz 08:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:12 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:12 INFO - Running setup.py install for blobuploader 08:41:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:12 INFO - Running setup.py install for requests 08:41:12 INFO - Running setup.py install for docopt 08:41:12 INFO - Successfully installed blobuploader requests docopt 08:41:12 INFO - Cleaning up... 08:41:13 INFO - Return code: 0 08:41:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:13 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 0x10b1b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b12d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddc2ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afcbd30>, '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 0x10ae31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afc3b20>, '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.GGFcorvvrb/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.evHZCqPLFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GGFcorvvrb/Render', 08:41:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:13 INFO - 'HOME': '/Users/cltbld', 08:41:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:13 INFO - 'LOGNAME': 'cltbld', 08:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:13 INFO - 'MOZ_NO_REMOTE': '1', 08:41:13 INFO - 'NO_EM_RESTART': '1', 08:41:13 INFO - 'PAGER': '/bin/cat', 08:41:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:13 INFO - 'PWD': '/builds/slave/test', 08:41:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:13 INFO - 'SHELL': '/bin/bash', 08:41:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.evHZCqPLFH/Listeners', 08:41:13 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 08:41:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:13 INFO - 'USER': 'cltbld', 08:41:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:13 INFO - 'XPC_FLAGS': '0x0', 08:41:13 INFO - 'XPC_SERVICE_NAME': '0', 08:41:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:13 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Ohuu44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:13 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-hfMN0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:13 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-JDMM1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:13 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-CdhkCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:13 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-epnlX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:13 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-ujkcxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:13 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-o2shJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:14 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-RVvuoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:14 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Y0pyp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:14 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-0zV1N4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:14 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-1DfFUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:14 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-L0pYAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:14 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-EaL1LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:14 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-52cR15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:14 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-6QV8Th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:14 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-G6sei6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:14 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-7y0SlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:15 INFO - Running setup.py install for manifestparser 08:41:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:15 INFO - Running setup.py install for mozcrash 08:41:15 INFO - Running setup.py install for mozdebug 08:41:15 INFO - Running setup.py install for mozdevice 08:41:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:15 INFO - Running setup.py install for mozfile 08:41:15 INFO - Running setup.py install for mozhttpd 08:41:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:15 INFO - Running setup.py install for mozinfo 08:41:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:16 INFO - Running setup.py install for mozInstall 08:41:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:16 INFO - Running setup.py install for mozleak 08:41:16 INFO - Running setup.py install for mozlog 08:41:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:16 INFO - Running setup.py install for moznetwork 08:41:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:16 INFO - Running setup.py install for mozprocess 08:41:16 INFO - Running setup.py install for mozprofile 08:41:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:17 INFO - Running setup.py install for mozrunner 08:41:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:17 INFO - Running setup.py install for mozscreenshot 08:41:17 INFO - Running setup.py install for moztest 08:41:17 INFO - Running setup.py install for mozversion 08:41:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:17 INFO - Cleaning up... 08:41:17 INFO - Return code: 0 08:41:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:17 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 0x10b1b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b12d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddc2ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afcbd30>, '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 0x10ae31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afc3b20>, '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.GGFcorvvrb/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.evHZCqPLFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GGFcorvvrb/Render', 08:41:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:17 INFO - 'HOME': '/Users/cltbld', 08:41:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:17 INFO - 'LOGNAME': 'cltbld', 08:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:17 INFO - 'MOZ_NO_REMOTE': '1', 08:41:17 INFO - 'NO_EM_RESTART': '1', 08:41:17 INFO - 'PAGER': '/bin/cat', 08:41:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:17 INFO - 'PWD': '/builds/slave/test', 08:41:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:17 INFO - 'SHELL': '/bin/bash', 08:41:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.evHZCqPLFH/Listeners', 08:41:17 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 08:41:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:17 INFO - 'USER': 'cltbld', 08:41:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:17 INFO - 'XPC_FLAGS': '0x0', 08:41:17 INFO - 'XPC_SERVICE_NAME': '0', 08:41:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:17 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-91uFPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:18 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-YHVNgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:18 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Mqz2X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:18 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-FaURlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:18 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-KDdiUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:18 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-4mFLBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:18 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-wrL0_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:18 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-sS05AB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:18 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-cH9RnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:18 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-3rUiSU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:18 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)) 08:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:19 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-7YlqzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:19 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-xnxgA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:19 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-7wyvbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:19 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-kG7Hyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:19 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-ybDI27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:19 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-HF_TOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:19 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-IudWdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:22 INFO - Downloading blessings-1.6.tar.gz 08:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:22 INFO - Installing collected packages: blessings 08:41:22 INFO - Running setup.py install for blessings 08:41:22 INFO - Successfully installed blessings 08:41:22 INFO - Cleaning up... 08:41:22 INFO - Return code: 0 08:41:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:22 INFO - Reading from file tmpfile_stdout 08:41:22 INFO - Current package versions: 08:41:22 INFO - blessings == 1.6 08:41:22 INFO - blobuploader == 1.2.4 08:41:22 INFO - docopt == 0.6.1 08:41:22 INFO - functools32 == 3.2.3-2 08:41:22 INFO - jsonschema == 2.5.1 08:41:22 INFO - manifestparser == 1.1 08:41:22 INFO - mozInstall == 1.12 08:41:22 INFO - mozcrash == 0.17 08:41:22 INFO - mozdebug == 0.1 08:41:22 INFO - mozdevice == 0.48 08:41:22 INFO - mozfile == 1.2 08:41:22 INFO - mozhttpd == 0.7 08:41:22 INFO - mozinfo == 0.9 08:41:22 INFO - mozleak == 0.1 08:41:22 INFO - mozlog == 3.4 08:41:22 INFO - moznetwork == 0.27 08:41:22 INFO - mozprocess == 0.23 08:41:22 INFO - mozprofile == 0.28 08:41:22 INFO - mozrunner == 6.12 08:41:22 INFO - mozscreenshot == 0.1 08:41:22 INFO - mozsystemmonitor == 0.3 08:41:22 INFO - moztest == 0.7 08:41:22 INFO - mozversion == 1.4 08:41:22 INFO - psutil == 3.1.1 08:41:22 INFO - requests == 1.2.3 08:41:22 INFO - wsgiref == 0.1.2 08:41:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:23 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 0x10b1b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b12d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddc2ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afcbd30>, '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 0x10ae31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afc3b20>, '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.GGFcorvvrb/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.evHZCqPLFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GGFcorvvrb/Render', 08:41:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:23 INFO - 'HOME': '/Users/cltbld', 08:41:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:23 INFO - 'LOGNAME': 'cltbld', 08:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:23 INFO - 'MOZ_NO_REMOTE': '1', 08:41:23 INFO - 'NO_EM_RESTART': '1', 08:41:23 INFO - 'PAGER': '/bin/cat', 08:41:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:23 INFO - 'PWD': '/builds/slave/test', 08:41:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:23 INFO - 'SHELL': '/bin/bash', 08:41:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.evHZCqPLFH/Listeners', 08:41:23 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 08:41:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:23 INFO - 'USER': 'cltbld', 08:41:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:23 INFO - 'XPC_FLAGS': '0x0', 08:41:23 INFO - 'XPC_SERVICE_NAME': '0', 08:41:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:23 INFO - Cleaning up... 08:41:23 INFO - Return code: 0 08:41:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:23 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 0x10b1b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b12d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fddc2ca2300>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10afcbd30>, '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 0x10ae31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afc3b20>, '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.GGFcorvvrb/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.evHZCqPLFH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:41:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:41:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GGFcorvvrb/Render', 08:41:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:23 INFO - 'HOME': '/Users/cltbld', 08:41:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:23 INFO - 'LOGNAME': 'cltbld', 08:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:23 INFO - 'MOZ_NO_REMOTE': '1', 08:41:23 INFO - 'NO_EM_RESTART': '1', 08:41:23 INFO - 'PAGER': '/bin/cat', 08:41:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:23 INFO - 'PWD': '/builds/slave/test', 08:41:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:23 INFO - 'SHELL': '/bin/bash', 08:41:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.evHZCqPLFH/Listeners', 08:41:23 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 08:41:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:23 INFO - 'USER': 'cltbld', 08:41:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:23 INFO - 'XPC_FLAGS': '0x0', 08:41:23 INFO - 'XPC_SERVICE_NAME': '0', 08:41:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:24 INFO - Cleaning up... 08:41:24 INFO - Return code: 0 08:41:24 INFO - Running post-action listener: _resource_record_post_action 08:41:24 INFO - Running post-action listener: _start_resource_monitoring 08:41:24 INFO - Starting resource monitoring. 08:41:24 INFO - [mozharness: 2016-09-29 15:41:24.090131Z] Finished create-virtualenv step (success) 08:41:24 INFO - [mozharness: 2016-09-29 15:41:24.090997Z] Running install step. 08:41:24 INFO - Running pre-action listener: _resource_record_pre_action 08:41:24 INFO - Running main action method: install 08:41:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:24 INFO - Reading from file tmpfile_stdout 08:41:24 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:24 INFO - Reading from file tmpfile_stdout 08:41:24 INFO - Output received: 08:41:24 INFO - Usage: mozinstall [options] installer 08:41:24 INFO - Options: 08:41:24 INFO - -h, --help show this help message and exit 08:41:24 INFO - -d DEST, --destination=DEST 08:41:24 INFO - Directory to install application into. [default: 08:41:24 INFO - "/builds/slave/test"] 08:41:24 INFO - --app=APP Application being installed. [default: firefox] 08:41:24 INFO - mkdir: /builds/slave/test/build/application 08:41:24 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'] 08:41:24 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 08:41:56 INFO - Reading from file tmpfile_stdout 08:41:56 INFO - Output received: 08:41:56 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:41:56 INFO - Running post-action listener: _resource_record_post_action 08:41:56 INFO - [mozharness: 2016-09-29 15:41:56.750681Z] Finished install step (success) 08:41:56 INFO - [mozharness: 2016-09-29 15:41:56.750830Z] Running run-tests step. 08:41:56 INFO - Running pre-action listener: _resource_record_pre_action 08:41:56 INFO - Running main action method: run_tests 08:41:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:41:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:41:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:41:56 INFO - 2016-09-29 08:41:56.765 screenresolution[1634:7527] starting screenresolution argv=screenresolution get 08:41:56 INFO - 2016-09-29 08:41:56.768 screenresolution[1634:7527] Display 0: 1600x1200x32@60 08:41:56 INFO - 2016-09-29 08:41:56.774 screenresolution[1635:7529] starting screenresolution argv=screenresolution list 08:41:56 INFO - Available Modes on Display 0 08:41:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:41:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:41:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:41:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:41:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:41:57 INFO - Intel Iris: 08:41:57 INFO - Chipset Model: Intel Iris 08:41:57 INFO - Type: GPU 08:41:57 INFO - Bus: Built-In 08:41:57 INFO - VRAM (Dynamic, Max): 1536 MB 08:41:57 INFO - Vendor: Intel (0x8086) 08:41:57 INFO - Device ID: 0x0a2e 08:41:57 INFO - Revision ID: 0x0009 08:41:57 INFO - Displays: 08:41:57 INFO - Display: 08:41:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:41:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:41:57 INFO - Display Serial Number: 1600x1200 60 08:41:57 INFO - Main Display: Yes 08:41:57 INFO - Mirror: Off 08:41:57 INFO - Online: Yes 08:41:57 INFO - Rotation: Supported 08:41:57 INFO - Return code: 0 08:41:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:57 INFO - Python 2.7.3 08:41:57 INFO - Return code: 0 08:41:57 INFO - grabbing minidump binary from tooltool 08:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:57 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 0x10afcbd30>, '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 0x10ae31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10afc3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:57 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:41:57 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:41:57 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:41:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:57 INFO - Return code: 0 08:41:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:41:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:41:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:57 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/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--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 08:41:57 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/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0311 --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 08:41:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GGFcorvvrb/Render', 08:41:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:57 INFO - 'HOME': '/Users/cltbld', 08:41:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:57 INFO - 'LOGNAME': 'cltbld', 08:41:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:41:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:57 INFO - 'MOZ_NO_REMOTE': '1', 08:41:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:57 INFO - 'NO_EM_RESTART': '1', 08:41:57 INFO - 'PAGER': '/bin/cat', 08:41:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:57 INFO - 'PWD': '/builds/slave/test', 08:41:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:57 INFO - 'SHELL': '/bin/bash', 08:41:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.evHZCqPLFH/Listeners', 08:41:57 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 08:41:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:57 INFO - 'USER': 'cltbld', 08:41:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:57 INFO - 'XPC_FLAGS': '0x0', 08:41:57 INFO - 'XPC_SERVICE_NAME': '0', 08:41:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:57 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/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--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 08:41:57 INFO - mozversion application_buildid: 20160929070429 08:41:57 INFO - mozversion application_changeset: 25c9e1f272a79d4000ce1b3ea4b909fdfbd95ece 08:41:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:41:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:57 INFO - mozversion application_name: Firefox 08:41:57 INFO - mozversion application_remotingname: firefox-dev 08:41:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:41:57 INFO - mozversion application_vendor: Mozilla 08:41:57 INFO - mozversion application_version: 51.0a2 08:41:57 INFO - mozversion platform_buildid: 20160929070429 08:41:57 INFO - mozversion platform_changeset: 25c9e1f272a79d4000ce1b3ea4b909fdfbd95ece 08:41:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:41:57 INFO - mozversion platform_version: 51.0a2 08:41:57 INFO - using testdate: 1475163717 08:41:57 INFO - actual date: 1475163717 08:41:57 INFO - starting webserver on 'localhost:49271' 08:41:57 INFO - SUITE-START | Running 2 tests 08:41:57 INFO - TEST-START | dromaeo_css 08:41:57 INFO - operating with platform_type : mac_ 08:41:57 INFO - Initialising browser for dromaeo_css test... 08:41:57 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpMLMY_J/profile http://localhost:49271/getInfo.html) 08:41:59 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 08:41:59 INFO - PROCESS | 1645 | colorDepth:24 08:41:59 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 08:41:59 INFO - PROCESS | 1645 | __metrics 08:41:59 INFO - PROCESS | 1645 | 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" 08:41:59 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:00 INFO - TEST-INFO | 1645: exit 0 08:42:00 INFO - Browser initialized. 08:42:00 INFO - Running cycle 1/1 for dromaeo_css test... 08:42:00 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpMLMY_J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:12 INFO - PROCESS | 1647 | RSS: Main: 219062272 08:42:12 INFO - PROCESS | 1647 | 08:43:03 INFO - PROCESS | 1647 | 1475163783649 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:45:15 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 08:45:17 INFO - PROCESS | 1647 | RSS: Main: 359047168 08:45:17 INFO - PROCESS | 1647 | 08:48:20 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 08:48:20 INFO - PROCESS | 1647 | RSS: Main: 351768576 08:48:20 INFO - PROCESS | 1647 | 08:51:23 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 08:51:23 INFO - PROCESS | 1647 | RSS: Main: 326152192 08:51:23 INFO - PROCESS | 1647 | 08:54:26 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 08:54:26 INFO - PROCESS | 1647 | RSS: Main: 322772992 08:54:26 INFO - PROCESS | 1647 | 08:57:29 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 08:57:30 INFO - PROCESS | 1647 | RSS: Main: 315101184 08:57:30 INFO - PROCESS | 1647 | 09:00:33 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 09:00:33 INFO - PROCESS | 1647 | RSS: Main: 417288192 09:00:33 INFO - PROCESS | 1647 | 09:00:33 INFO - PROCESS | 1647 | __start_tp_report 09:00:33 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 09:00:33 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 09:00:33 INFO - PROCESS | 1647 | |i|pagename|runs| 09:00:33 INFO - PROCESS | 1647 | |0;dojo.html;3297.967020329797;3324.135724711575;3355.1779813945586;3356.2784001439686;3396.23584693444;5701;5778.65328080315;5778.768849246036;5794;5830.795922142721;5712.800051998181;5772.076467765159;5784.56615753818;5787.305523337195;5791.884162316751;5231.65994210377;5274.129768588197;5286.31277933868;5297.973510132444;5331.280277162592;5205.713685747282;5227.5295223429885;5238.633295669305;5363.597730170233;5400.864978375533;5311.176767601028;5320.893582128355;5339.439358867321;5344.652597581165;5346.224797404374;5218.843434696965;5256.579473642099;5278.868028299304;5283.339582552181;5310.150375939869;5205.791768329263;5220.269162317279;5296.417394086648;5303;5304.708241046741;5581.441855814427;5633.0987042073075;5750.0224961756185;5757.280339957505;5821.388754180834;6145.555794388315;6172.969135154295;6208.441240288351;6208.596441231305;6238.1578486904145;6271.717772700239;6306.810795676137;6314.810555683291;6363.93636063638;6372;5678;5834.329052159013;5851;5858.974679431082;5891.086881533369;6226.501879849601;6270.216222972129;6321.936780632135;6330.8417289567205;6361.9045714314325;6213.96893015532;6220.315765265817;6220.564560480723;6224.035274532454;6236.563440559117;6299.622022678654;6317.368263173646;6323.146375239376;6332.303446620868;6332.430081292614;6093.451589356979;6097.3292937776805;6134.191047936786;6137.2310028573;6182.258129024546;6296.811095667137;6297.937020629826;6299.307076221612;6300.747970081237;6302.306746257908;4904;4935.3090567320605;4938.012397520511;4952.90094198114;4961.603071754251;4357.324614684729;4383.452068491439;4430.313301438282;4470.97167651442;4475.641948644101;5667.1499275108235;5752.798652047159;5764.855878602984;5774.509166720792;5776.595638305363;6330.050492426173;6335.366463353628;6353.396427339396;6356.396142366468;6356.618602883842;5746.109353050284;5752.712364381764;5778.422157784188;5781.624194427349;5831.708414579254;5350.91973620396;5358.54452371545;5365.597580181502;5387.24578559002;5413.702246376487;6287.1198032275515;6357;6357.14178585885;6368.458681011981;6373.330800265905;6229.844253893689;6364.904526432199;6365.681715914093;6375.330590287953;6376.553641245068;6281.277653069773;6335.3981371769605;6348.619082855043;6355.7457701693265;6360.109584658059;6105.419985101586;6158.938410615837;6177.351378105414;6268.153799237227;6276.340984196594;6122.418370254819;6342.080398342122;6342.619442833445;6352.333005034405;6367.140436041075;5922.73347699346;5946.554008449297;6108.57239993214;6149.108379285068;6166.383361663798;5992.880142397041;6037.124616930609;6076.513878889767;6077.726502307319;6116.541259405473;6041.305249896318;6045.697715114139;6045.879082418415;6063.333033366238;6084.361142080195;6078.3617720138745;6148.538859585459;6175.197224360984;6188.566800324114;6189.535784816067;4849.660523763303;5789.594728368974;5844.47399734009;5980.551458640706;6004.309504407049 09:00:33 INFO - PROCESS | 1647 | |1;ext.html;463.4600690195922;517.066694616218;520.9374875014996;540.6782964136339;543.5379927061997;30122.246943826416;39170.804145979266;40496.19007619846;40531.392029119546;42663.36004959921;42145.15709685804;42522.149557008845;42586.57413425865;42595.78702106493;42627.36058959118;9806.55870485828;9970.601175952954;9985.201183905307;9988.650397236099;9992.350497217658;9830.459324737136;9941.055599718014;9975.102240798327;9976.75058123549;9977.451240181786;9955.303128780988;9995.90004099957;9997.450140242283;10012.098911097999;10037.849432258521;9852.408855468659;9961.203103751683;9968.900310996869;9970.302078854484;9996.350237234556;8489.575521223915;9809.705708828675;9913.40519568821;9929.50352482373;9931;39571.60428395708;39939.8003009986;40000.79993600505;40040.79979600113;40059.7997010016;3031.7726170537076;3394.0835974286806;3405.6934875861293;3492.2840817632323;3849.942250866239;29384.265393365124;29458;29494.85252573745;30974;31791.205219869687;3072.293372524332;3100.3954228925368;3142.418652549263;3285.3100848821778;3295.0938491914917;509661;509980;515707.421462894;516155;518651;60371;60933.78132437327;60938;60940;61071.08393374103;34209;34694.30611387758;34779.652203478145;36049.639503605154;36081.8195909024;17114.572135696457;17321.826781732274;17323.960562366046;17331.133443327784;17344.91327543354;13186.670333241746;13299.734005319839;13315.267660278778;13324.933375333256;13331.933340333237;18912;18945.957972311655;18948.43154705361;18970.90514547446;18976;6747;7974.202579741979;8079.272865442138;8134.511929284262;8136.593170341459;834.4367551902442;900.3247564326755;901.5987885391069;936.391345625349;1154.0421450196318;24178;28939;29604;29931;30343.544846827313;757.2238455583072;901.2654686430539;1093.4040947683532;1121.8205087186175;1135.7444574970566;11128.443577821077;16023.038617682976;16217.108059056865;16325.26536305869;16827.74758378625;670134;672568;672653;672968;674603;56792.14811777827;57276.713616432484;57463.56341091506;57567.712161438925;57595;1235.2279825109306;1266.9303188324545;1316.55895275082;1359.5717349035021;1399.6151058458597;28053.43893122085;28700.282492937844;29746.553801693426;29926.401471970003;30419.847900760353;47320.763396182796;47949.520504794506;48070;48098;48120.7593962028;546133;551777;552837;662863;666578;40811.38782918199;41140.382894256014;41385.37921931113;41423.37864931968;41658.79170604127;39317.6068239314;43932.78033609811;45303.77348113238;45752.771236143606;46038.849028773206;36505.45241821428;37012.44481332728;38139.42790858084;39118.60881391264;39157.804210978764;37335;37970.8101459502;38115.80942095272;38164.618353816106;39215.803920980215;36564;37455.81272093622;37675.246495070496;37894.621053790215;37969.24061518809;30182.943596974;31416.68583314229;32703.018909432754;33081.50377744384;33962.49056264207;24655.50688986246;24865.254042378758;25104.874475627505;25142.49715005653;25696.614550782127 09:00:33 INFO - PROCESS | 1647 | |2;jquery.html;347.6245654692932;348.05503059194314;369.3554746966543;373.0915221435804;381.4811855876009;15063.698726025474;15284.465043723472;18794.43616691498;21108.472288192763;21137.894310528427;19662;20733.68899466509;20953.952302384896;20955.266565670205;20996.580068398624;5897.675627840467;6138.815835524919;6157.538184636148;6164.445199932005;6164.7534098636;4094.9385759213637;4362.585554372329;6886.621235832027;6935.375816176543;6964.4080253178545;6556.770513032045;6774.559653622498;6898.413634841045;6914.412274956635;6917.481188910827;6685.4985876059;6745.898811517831;6801.761938332159;6838.692258848364;6842.52102352838;5645.520130788888;5815.331236907768;5873;5883.058710606325;5887.558433117533;24723.752762472326;25211.747882521122;25288.747112529007;25447.491050179076;25681.871590642113;2252.526969336441;2337.100216416675;2409.1808785013004;2838.6025956366125;3180.173154979722;14709.632259193499;15760.842391576052;15973.840261597352;15981;16203.918980405022;1815.8638102142393;1908.1222637586588;1908.6659834528903;1933.1397528100001;1961.9607607847763;113528;117317.41341293324;117512;118050.81949180484;128347;11334.489947952361;11531.538738450536;11671.824922626167;11755.353455560027;11895.799277133758;14635.121892686473;14664.046836955564;14664.926675366769;14675.486357977634;14680.04579702316;8467.83064338722;8597.441166324168;8629.654813807503;8658.956705216433;8755.605997730117;8600.655973760979;8638.827223455495;8654.697085601974;8744;8751.431156974777;4513.842015529441;4527.592516673515;4547;4560.5895469407915;4608.723476591415;1895.753532064508;1915.6456055629474;1916.4154932745646;1917.1277068933603;1942.4464027752024;825.145973917005;905.8892779822996;922.8385032619265;930.4045410937006;980.3774603127066;17478;20025.599488010157;21344.893275533523;21517.56964860694;21559.784402156092;839.4207996482407;914.6752902719572;924.6209054287709;934.5000424772714;951.3007939164709;8752.862127923328;10464.424456654804;11154;11159.888401115884;11172.720681983015;583727;604326;607051;616191;623158;74872.25127748762;75730;77282.61358693171;126419.31113099933;132683;944.2681921510884;952.6046690623314;953.9379940303719;973.3089506450499;974.1670871404989;18321.633567328845;18915.90542047281;19477.51306217356;19513.024348782787;19547;53044;56388.71805640945;57981;58111;58834;79932.60033699794;81601.59199203966;84693;85548.14451855402;86589.56705216433;8019.438639295194;8035.919640803517;8043.6782528698195;8058.153893841297;8238.794030149294;8943.418677785923;12736.554220602235;12997.870021300045;13244.867551324363;13323.733525329246;10752.946235268773;10948.671539853816;11275.210735248455;11326.37704926204;11565.241296578477;9227.44635321883;10962.397068161008;10967.561297548009;11093.00162985303;11163.832542512031;11204;11218.214724969173;11372.260803047775;11404.372759498307;11532.25040372373;7822.374210063295;8009.719659812112;8166.918330816616;8189.262966333059;8370.623321950405;10292.330998485075;11041.834372484258;11273.943630281796;11380.772384552429;11531.769364612828 09:00:33 INFO - PROCESS | 1647 | |3;mootools.html;1535.470262759348;1544.5366390082975;1612.459825958304;1855.5268406556327;1861.6649003179423;8519.574021298933;9014.684486042974;9027.142421469965;9028.54857257137;9037;7137.892931606017;7869.2130786921425;8124.512529248249;8814.986276578196;8829.514376709278;2407.325948734353;2447.486027934136;2447.79193768529;2447.9388015299583;2448.7511369201748;2414.1188466209883;2420.1408499982517;2454.8772561371948;2455.2388759484616;2458.0045081741923;2425.6967879015124;2439.0365805506813;2442;2448.804095672342;2449.35092200567;2395.5089206712582;2403.51929614077;2410.011895123009;2415.4444477770035;2419.11702228687;2413.095089341497;2420.189236605739;2423.6243382275597;2428.9757102428925;2430.635404689293;8841.336899732545;8943.686970955985;8977.371583989123;9022.639094436214;9043.954780226057;5275.86810329741;5458.781648734046;5459.645123067027;5464.808731694411;5467.58993075517;3450.603180634234;3589.6410358964154;3639.217568222845;3655.342038433081;3682.558093028827;1072.554889720765;1095.802755504009;1107.8393632923262;1120.5685810962757;1125.5047778977223;10337.966203379678;11670.649880503599;11789.410529473578;11820.822687659605;11870.109741769402;4373.781310934441;4583.381243532147;4890.657653964259;4910.754462276872;4917.532834380728;10077;10080.899191008142;10087.69736907894;10095.091441770275;10101.898981010096;5433.701146436905;5439.347278326626;5445.210444485607;5446.2375267462585;5453.072977593819;4456.487503937024;4610.95389046112;4756.476787553366;4951.851444456672;4972.378452693413;3959.247742928834;3989.401589761501;4101;4129.132882094734;4134.1731653669385;1297.5134324628264;1317.953871614508;1319.4919955816888;1330.5409633676366;1331;807.2815194476921;907.6641642592283;912.261068534476;931.362017018331;934.7008957133788;5766.481016708516;5768.163616275617;5858.560607954335;5994.9700251499335;6139.324674285825;450.70929250633156;454.01478791023555;461.0157314134347;1013.1287093099928;1023.4064242739194;3979.442877997025;4019.6784257259933;4028.8388464461677;4161.9375709364385;4194.454720886265;10643.41461219625;11027.61403350879;11028.834567481494;11030.952059554329;11043.282186658002;10824.621138260281;10968.835467467994;10995.670129895956;10995.725106872393;11013.559457621766;7454.664540095709;8207.712730054538;8369.288610468057;8375.371847111492;8391.748247552461;5137.845864624067;5804.100364443518;5814.680192589279;5929;6088.178095956989;7658.770236892902;10325.277230594087;10410.947945260225;10416.739581510523;10423;9901.306908516335;10286.588536458457;10357.585696572354;10499.475026248505;10506.159507239556;7062.1878483975;7298.890516642148;7406.518576292524;7514.511556748794;7745.612719363897;8393.160683931557;8588.957055214683;8597.828043439222;8609.440386374865;8615.439996400213;7423.814404639711;7460.142083660448;7544.660490277841;7620.1998790128455;7706.190849960898;7317.26827317264;7476.962615186889;7503.09962804467;7648.158702542827;7707.576083315472;6163.691815409301;7082.645867706698;7256.4194864411775;7259.366642505394;7295.927040729524;4963.255511673278;5051.722155281494;5115.232715092766;5125.589952803842;5157.458466860926;5001.524855138756;5060.696358218519;5187.403448603308;5195.142801437721;5226.947730522646 09:00:33 INFO - PROCESS | 1647 | |4;prototype.html;302.227807950686;305.13189974522487;309.7166093024882;315.97472202223827;318.55402436588787;3793.184465339951;4452.821887124515;5300.257963885059;5331.413544510106;5356.00977271932;4869.297539865373;5107.3871135463705;5227.4511176326505;5298.403782146749;5340.572754179666;4074;4082.6121518455698;4091.9590804092027;4119.958800411988;4120.958790412095;3933.718443302892;3951.486306780115;4112.403701463286;4120.3201471757275;4121.608447197526;3323.9501407478906;3328.6019871653843;3524.400851855191;4038.172174704179;4066.755994640331;3217.1796191971016;3666.578343490506;4031.3952907064026;4068.9796551017353;4069.5930406959365;3092.2528771244174;3300.224447254893;3477.687008169277;3523.9119022024397;3565.625609311011;4214;4498.032922921555;4757.738324392157;5042.546170844605;5150.175971844525;4549.931751023737;4553.726776393427;4560.452745670507;4571.291449825282;4595.471520775121;5039.933627212862;5409.891802163935;5489.615726899118;5602.971985140089;5624.859378515529;3745.8721967157458;3796.2597293527774;3806.809659517041;3807.447920051577;3821.445890345912;5271.441776800682;5563;5873.207117039187;5882.352941176498;5911.728978269693;3022.5466180072726;3758.248350329945;3852.556955950102;3852.8651497197466;3856.7878766668105;3415.880444184442;3941.704372172041;3945.6448919597374;3946.2699400610977;3967.8412863485714;4561.178987782231;4574.5425457453985;4590.219662657356;4598.770061496979;4633.772050406645;5432.158015507603;5618.943810561924;5651.106879195433;5653;5669.234653321749;1193.373478923572;1200.2498438475952;1310.8661008227814;1327.7875539913568;1346.501794336102;690.3648643248224;803.7588723383078;812.3257696112213;816.9135050382977;819.2094628683349;3854.6530812227033;4089.7955102245364;4093.5497095319492;4188.28799104153;4371.617468479686;4102.835886564564;4255.659547236213;4386.407834942306;4702.811887524461;4812.590929770939;4196.307609244441;4389.122175564899;4408.955910440919;4426.251630605892;4428.250840917819;2248.820094392445;2404.7835694787555;2425.3815277104577;2495.8752062396807;2511.962320565193;4555.175791009529;4622.583967442946;4826.918083215174;4853.635977301717;4896.3352460163715;4280.5505421930875;4345.478542574848;4641.303804429363;4916.631252656065;5030.949690503048;3890.0469385000856;4058.228936502055;4397.868063958086;5007.499250075036;5008.474110218447;4725.10223057618;4749.430068391815;4755.976220118877;4821.807127714852;4894.559489645949;4528.954710452853;4677.555632214934;4705.67060305789;4711.78796954131;4816.277558366133;4594.264917613166;4996.3504744383;5078.296648424045;6021.698915054142;6038.788642397495;3262.706356427933;3635.5092062571216;3776.4524143999515;3779.4519794629073;3909.139989202371;4851.320815085962;5711.742971566373;5842.532597392284;5869.236999190078;5886.793962211302;4716.410448693913;5691.288588926384;5698.344690360662;5699.8860022800145;5703.344115426779;4727.739974301447;5224.7126408047925;5297.860959893641;5633.63381380209;5692.829215123553;5093.981203759337;5579.497845193952;5588.636738611977;5593.188987596857;5594.692291923983;5347.117725575236;5660.405657405913;5671.943280567141;5686.573506987075;5696.499765185457;4579.62611216627;5180.378354597472;5500.469783899451;5551.306086739158;5568.9443105568425 09:00:33 INFO - PROCESS | 1647 | |5;yui.html;718.9784306470806;808.6320724070548;808.8058865872189;819.8729196974471;820.3232333325006;14957.925210373947;15868.206589670513;15905.125218112998;15906.284217210225;15915.283812228448;15456;15552.53342399727;15587.688246235068;16394.508164755076;16410.17949102546;666.8366250268667;683.7367613468825;707.9185893622248;840.1430540848346;865.0138841720412;684.3464491410691;833.1585099049943;843.1905370843966;858.7509622209552;861.2205953611959;898.1467605774508;898.74385800047;900.522722956834;900.5542256583001;901.8151278987792;695.0373732380639;891.585412783059;892.7589550821274;893.2318206342541;893.3121496447699;531.0070168784398;534.0973754355127;534.1293691283183;534.6925517827265;645.5803727577065;15338;15676.137812420313;15683.137427441487;15695.529134125994;15697.764533532007;11474.426278686116;13573;13713.931430342784;13849.099808512414;13863.861361386358;11477.253978491455;11953.46209420578;11999.220050696676;12616.306103164323;12997.285149316784;3849.076221706798;3901.7854018028997;3961.6830653547645;3998.4402183694306;4002.0995276062945;111727;111790.44104779424;112533;112838;114460.42769786097;10586.947065264778;10883.619073332395;10994.835077473845;11060.778784424267;11360.715982100348;21884.23405180811;21946.231881884058;22047;22048.88975555112;22105.66841497379;7901.644426000728;7928.365730741642;7940.841183176304;7973.840523189504;8025.799355016171;4272.273713468718;4298.290782020931;4337.9783101084295;4402.207602631557;4420.425344705168;3464.6535346465153;3638.9636103639154;3640.4357324614725;3640.635936406391;3641.126129728899;626.8683576448906;655.0665301944709;663.2770280394296;668.2949488289804;669.7254125808493;514.282575806755;602.3554796367932;606.6026752477135;625.0280813335216;630.5649102119523;8514.914850851535;9206.401583897159;9266.490343031199;9410.153086222135;9410.917744459475;427.3952357414286;526.6076772804286;585.7217821534737;589.0898561722149;593.4273426143792;4429.734215947054;4499.820007199675;4527.366168736379;4529.501754806968;4603.217453032926;174034;176177;180165.0991745033;184792;188270;143710;148332;148572;154107;155406.4526451056;113523;123372;124367;128305.35847320891;128396.71603284034;8454.154584541497;8776.736697899074;8830.072842351718;8861.335399845166;8959.41763785352;68426.31573684199;69025;69937.65031174812;70481;71423;101969;106428;108351;110829;111150.44424777824;11616.709582260512;11680.415979200836;11822.40887955616;12112.273263604213;12135;10756.354618722902;12133.029357651543;12243.938780306398;12395.62813115608;12834.807477888025;13116.803247951097;13574.253416061816;14026.420683279839;14652.633684157981;14882;13548.796768048684;13650.313636839755;13754;14144.646383840487;14732.852671473149;13441.529546465827;13466.49355837427;13647.249401283025;13703.657408564866;13888.513902013381;11255.96058331938;11427.485763140512;11704.239224450383;11761.176717629683;12190.146689731633;10597.682069537927;10978.505967231653;11763.47064382122;11850.407479625812;12026.518939242682 09:00:33 INFO - PROCESS | 1647 | __end_tp_report 09:00:33 INFO - PROCESS | 1647 | __start_cc_report 09:00:33 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1380 09:00:33 INFO - PROCESS | 1647 | __end_cc_report 09:00:33 INFO - PROCESS | 1647 | __startTimestamp1475164833781__endTimestamp 09:00:33 INFO - PROCESS | 1647 | 09:00:33 INFO - PROCESS | 1647 | ------- Summary: start ------- 09:00:33 INFO - PROCESS | 1647 | Number of tests: 6 09:00:33 INFO - PROCESS | 1647 | 09:00:33 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5782.48 Median:6004.31 stddev:649.54 (10.8%) stddev-sans-first:621.61 09:00:33 INFO - PROCESS | 1647 | Values: 3298.0 3324.1 3355.2 3356.3 3396.2 5701.0 5778.7 5778.8 5794.0 5830.8 5712.8 5772.1 5784.6 5787.3 5791.9 5231.7 5274.1 5286.3 5298.0 5331.3 5205.7 5227.5 5238.6 5363.6 5400.9 5311.2 5320.9 5339.4 5344.7 5346.2 5218.8 5256.6 5278.9 5283.3 5310.2 5205.8 5220.3 5296.4 5303.0 5304.7 5581.4 5633.1 5750.0 5757.3 5821.4 6145.6 6173.0 6208.4 6208.6 6238.2 6271.7 6306.8 6314.8 6363.9 6372.0 5678.0 5834.3 5851.0 5859.0 5891.1 6226.5 6270.2 6321.9 6330.8 6361.9 6214.0 6220.3 6220.6 6224.0 6236.6 6299.6 6317.4 6323.1 6332.3 6332.4 6093.5 6097.3 6134.2 6137.2 6182.3 6296.8 6297.9 6299.3 6300.7 6302.3 4904.0 4935.3 4938.0 4952.9 4961.6 4357.3 4383.5 4430.3 4471.0 4475.6 5667.1 5752.8 5764.9 5774.5 5776.6 6330.1 6335.4 6353.4 6356.4 6356.6 5746.1 5752.7 5778.4 5781.6 5831.7 5350.9 5358.5 5365.6 5387.2 5413.7 6287.1 6357.0 6357.1 6368.5 6373.3 6229.8 6364.9 6365.7 6375.3 6376.6 6281.3 6335.4 6348.6 6355.7 6360.1 6105.4 6158.9 6177.4 6268.2 6276.3 6122.4 6342.1 6342.6 6352.3 6367.1 5922.7 5946.6 6108.6 6149.1 6166.4 5992.9 6037.1 6076.5 6077.7 6116.5 6041.3 6045.7 6045.9 6063.3 6084.4 6078.4 6148.5 6175.2 6188.6 6189.5 4849.7 5789.6 5844.5 5980.6 6004.3 09:00:33 INFO - PROCESS | 1647 | 09:00:33 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:71721.98 Median:39970.30 stddev:160233.47 (400.9%) stddev-sans-first:160593.65 09:00:33 INFO - PROCESS | 1647 | Values: 463.5 517.1 520.9 540.7 543.5 30122.2 39170.8 40496.2 40531.4 42663.4 42145.2 42522.1 42586.6 42595.8 42627.4 9806.6 9970.6 9985.2 9988.7 9992.4 9830.5 9941.1 9975.1 9976.8 9977.5 9955.3 9995.9 9997.5 10012.1 10037.8 9852.4 9961.2 9968.9 9970.3 9996.4 8489.6 9809.7 9913.4 9929.5 9931.0 39571.6 39939.8 40000.8 40040.8 40059.8 3031.8 3394.1 3405.7 3492.3 3849.9 29384.3 29458.0 29494.9 30974.0 31791.2 3072.3 3100.4 3142.4 3285.3 3295.1 509661.0 509980.0 515707.4 516155.0 518651.0 60371.0 60933.8 60938.0 60940.0 61071.1 34209.0 34694.3 34779.7 36049.6 36081.8 17114.6 17321.8 17324.0 17331.1 17344.9 13186.7 13299.7 13315.3 13324.9 13331.9 18912.0 18946.0 18948.4 18970.9 18976.0 6747.0 7974.2 8079.3 8134.5 8136.6 834.4 900.3 901.6 936.4 1154.0 24178.0 28939.0 29604.0 29931.0 30343.5 757.2 901.3 1093.4 1121.8 1135.7 11128.4 16023.0 16217.1 16325.3 16827.7 670134.0 672568.0 672653.0 672968.0 674603.0 56792.1 57276.7 57463.6 57567.7 57595.0 1235.2 1266.9 1316.6 1359.6 1399.6 28053.4 28700.3 29746.6 29926.4 30419.8 47320.8 47949.5 48070.0 48098.0 48120.8 546133.0 551777.0 552837.0 662863.0 666578.0 40811.4 41140.4 41385.4 41423.4 41658.8 39317.6 43932.8 45303.8 45752.8 46038.8 36505.5 37012.4 38139.4 39118.6 39157.8 37335.0 37970.8 38115.8 38164.6 39215.8 36564.0 37455.8 37675.2 37894.6 37969.2 30182.9 31416.7 32703.0 33081.5 33962.5 24655.5 24865.3 25104.9 25142.5 25696.6 09:00:33 INFO - PROCESS | 1647 | 09:00:33 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:34879.03 Median:358.71 stddev:100746.43 (28086.1%) stddev-sans-first:100995.69 09:00:33 INFO - PROCESS | 1647 | Values: 347.6 348.1 369.4 373.1 381.5 15063.7 15284.5 18794.4 21108.5 21137.9 19662.0 20733.7 20954.0 20955.3 20996.6 5897.7 6138.8 6157.5 6164.4 6164.8 4094.9 4362.6 6886.6 6935.4 6964.4 6556.8 6774.6 6898.4 6914.4 6917.5 6685.5 6745.9 6801.8 6838.7 6842.5 5645.5 5815.3 5873.0 5883.1 5887.6 24723.8 25211.7 25288.7 25447.5 25681.9 2252.5 2337.1 2409.2 2838.6 3180.2 14709.6 15760.8 15973.8 15981.0 16203.9 1815.9 1908.1 1908.7 1933.1 1962.0 113528.0 117317.4 117512.0 118050.8 128347.0 11334.5 11531.5 11671.8 11755.4 11895.8 14635.1 14664.0 14664.9 14675.5 14680.0 8467.8 8597.4 8629.7 8659.0 8755.6 8600.7 8638.8 8654.7 8744.0 8751.4 4513.8 4527.6 4547.0 4560.6 4608.7 1895.8 1915.6 1916.4 1917.1 1942.4 825.1 905.9 922.8 930.4 980.4 17478.0 20025.6 21344.9 21517.6 21559.8 839.4 914.7 924.6 934.5 951.3 8752.9 10464.4 11154.0 11159.9 11172.7 583727.0 604326.0 607051.0 616191.0 623158.0 74872.3 75730.0 77282.6 126419.3 132683.0 944.3 952.6 953.9 973.3 974.2 18321.6 18915.9 19477.5 19513.0 19547.0 53044.0 56388.7 57981.0 58111.0 58834.0 79932.6 81601.6 84693.0 85548.1 86589.6 8019.4 8035.9 8043.7 8058.2 8238.8 8943.4 12736.6 12997.9 13244.9 13323.7 10752.9 10948.7 11275.2 11326.4 11565.2 9227.4 10962.4 10967.6 11093.0 11163.8 11204.0 11218.2 11372.3 11404.4 11532.3 7822.4 8009.7 8166.9 8189.3 8370.6 10292.3 11041.8 11273.9 11380.8 11531.8 09:00:33 INFO - PROCESS | 1647 | 09:00:33 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5770.44 Median:2535.98 stddev:3225.95 (127.2%) stddev-sans-first:3219.30 09:00:33 INFO - PROCESS | 1647 | Values: 1535.5 1544.5 1612.5 1855.5 1861.7 8519.6 9014.7 9027.1 9028.5 9037.0 7137.9 7869.2 8124.5 8815.0 8829.5 2407.3 2447.5 2447.8 2447.9 2448.8 2414.1 2420.1 2454.9 2455.2 2458.0 2425.7 2439.0 2442.0 2448.8 2449.4 2395.5 2403.5 2410.0 2415.4 2419.1 2413.1 2420.2 2423.6 2429.0 2430.6 8841.3 8943.7 8977.4 9022.6 9044.0 5275.9 5458.8 5459.6 5464.8 5467.6 3450.6 3589.6 3639.2 3655.3 3682.6 1072.6 1095.8 1107.8 1120.6 1125.5 10338.0 11670.6 11789.4 11820.8 11870.1 4373.8 4583.4 4890.7 4910.8 4917.5 10077.0 10080.9 10087.7 10095.1 10101.9 5433.7 5439.3 5445.2 5446.2 5453.1 4456.5 4611.0 4756.5 4951.9 4972.4 3959.2 3989.4 4101.0 4129.1 4134.2 1297.5 1318.0 1319.5 1330.5 1331.0 807.3 907.7 912.3 931.4 934.7 5766.5 5768.2 5858.6 5995.0 6139.3 450.7 454.0 461.0 1013.1 1023.4 3979.4 4019.7 4028.8 4161.9 4194.5 10643.4 11027.6 11028.8 11031.0 11043.3 10824.6 10968.8 10995.7 10995.7 11013.6 7454.7 8207.7 8369.3 8375.4 8391.7 5137.8 5804.1 5814.7 5929.0 6088.2 7658.8 10325.3 10410.9 10416.7 10423.0 9901.3 10286.6 10357.6 10499.5 10506.2 7062.2 7298.9 7406.5 7514.5 7745.6 8393.2 8589.0 8597.8 8609.4 8615.4 7423.8 7460.1 7544.7 7620.2 7706.2 7317.3 7477.0 7503.1 7648.2 7707.6 6163.7 7082.6 7256.4 7259.4 7295.9 4963.3 5051.7 5115.2 5125.6 5157.5 5001.5 5060.7 5187.4 5195.1 5226.9 09:00:33 INFO - PROCESS | 1647 | 09:00:33 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4274.47 Median:4584.92 stddev:1325.30 (28.9%) stddev-sans-first:1295.05 09:00:33 INFO - PROCESS | 1647 | Values: 302.2 305.1 309.7 316.0 318.6 3793.2 4452.8 5300.3 5331.4 5356.0 4869.3 5107.4 5227.5 5298.4 5340.6 4074.0 4082.6 4092.0 4120.0 4121.0 3933.7 3951.5 4112.4 4120.3 4121.6 3324.0 3328.6 3524.4 4038.2 4066.8 3217.2 3666.6 4031.4 4069.0 4069.6 3092.3 3300.2 3477.7 3523.9 3565.6 4214.0 4498.0 4757.7 5042.5 5150.2 4549.9 4553.7 4560.5 4571.3 4595.5 5039.9 5409.9 5489.6 5603.0 5624.9 3745.9 3796.3 3806.8 3807.4 3821.4 5271.4 5563.0 5873.2 5882.4 5911.7 3022.5 3758.2 3852.6 3852.9 3856.8 3415.9 3941.7 3945.6 3946.3 3967.8 4561.2 4574.5 4590.2 4598.8 4633.8 5432.2 5618.9 5651.1 5653.0 5669.2 1193.4 1200.2 1310.9 1327.8 1346.5 690.4 803.8 812.3 816.9 819.2 3854.7 4089.8 4093.5 4188.3 4371.6 4102.8 4255.7 4386.4 4702.8 4812.6 4196.3 4389.1 4409.0 4426.3 4428.3 2248.8 2404.8 2425.4 2495.9 2512.0 4555.2 4622.6 4826.9 4853.6 4896.3 4280.6 4345.5 4641.3 4916.6 5030.9 3890.0 4058.2 4397.9 5007.5 5008.5 4725.1 4749.4 4756.0 4821.8 4894.6 4529.0 4677.6 4705.7 4711.8 4816.3 4594.3 4996.4 5078.3 6021.7 6038.8 3262.7 3635.5 3776.5 3779.5 3909.1 4851.3 5711.7 5842.5 5869.2 5886.8 4716.4 5691.3 5698.3 5699.9 5703.3 4727.7 5224.7 5297.9 5633.6 5692.8 5094.0 5579.5 5588.6 5593.2 5594.7 5347.1 5660.4 5671.9 5686.6 5696.5 4579.6 5180.4 5500.5 5551.3 5568.9 09:00:33 INFO - PROCESS | 1647 | 09:00:33 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:27437.60 Median:21915.23 stddev:45986.28 (209.8%) stddev-sans-first:46071.53 09:00:33 INFO - PROCESS | 1647 | Values: 719.0 808.6 808.8 819.9 820.3 14957.9 15868.2 15905.1 15906.3 15915.3 15456.0 15552.5 15587.7 16394.5 16410.2 666.8 683.7 707.9 840.1 865.0 684.3 833.2 843.2 858.8 861.2 898.1 898.7 900.5 900.6 901.8 695.0 891.6 892.8 893.2 893.3 531.0 534.1 534.1 534.7 645.6 15338.0 15676.1 15683.1 15695.5 15697.8 11474.4 13573.0 13713.9 13849.1 13863.9 11477.3 11953.5 11999.2 12616.3 12997.3 3849.1 3901.8 3961.7 3998.4 4002.1 111727.0 111790.4 112533.0 112838.0 114460.4 10586.9 10883.6 10994.8 11060.8 11360.7 21884.2 21946.2 22047.0 22048.9 22105.7 7901.6 7928.4 7940.8 7973.8 8025.8 4272.3 4298.3 4338.0 4402.2 4420.4 3464.7 3639.0 3640.4 3640.6 3641.1 626.9 655.1 663.3 668.3 669.7 514.3 602.4 606.6 625.0 630.6 8514.9 9206.4 9266.5 9410.2 9410.9 427.4 526.6 585.7 589.1 593.4 4429.7 4499.8 4527.4 4529.5 4603.2 174034.0 176177.0 180165.1 184792.0 188270.0 143710.0 148332.0 148572.0 154107.0 155406.5 113523.0 123372.0 124367.0 128305.4 128396.7 8454.2 8776.7 8830.1 8861.3 8959.4 68426.3 69025.0 69937.7 70481.0 71423.0 101969.0 106428.0 108351.0 110829.0 111150.4 11616.7 11680.4 11822.4 12112.3 12135.0 10756.4 12133.0 12243.9 12395.6 12834.8 13116.8 13574.3 14026.4 14652.6 14882.0 13548.8 13650.3 13754.0 14144.6 14732.9 13441.5 13466.5 13647.2 13703.7 13888.5 11256.0 11427.5 11704.2 11761.2 12190.1 10597.7 10978.5 11763.5 11850.4 12026.5 09:00:33 INFO - PROCESS | 1647 | -------- Summary: end -------- 09:00:33 INFO - PROCESS | 1647 | 09:00:34 INFO - TEST-INFO | 1647: exit 0 09:00:34 INFO - TEST-OK | dromaeo_css | took 1117044ms 09:00:34 INFO - TEST-START | kraken 09:00:34 INFO - operating with platform_type : mac_ 09:00:34 INFO - Initialising browser for kraken test... 09:00:34 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpDZo6zQ/profile http://localhost:49271/getInfo.html) 09:00:36 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 09:00:36 INFO - PROCESS | 1656 | colorDepth:24 09:00:36 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 09:00:36 INFO - PROCESS | 1656 | __metrics 09:00:36 INFO - PROCESS | 1656 | 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" 09:00:36 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:37 INFO - TEST-INFO | 1656: exit 0 09:00:37 INFO - Browser initialized. 09:00:37 INFO - Running cycle 1/1 for kraken test... 09:00:37 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpDZo6zQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:49 INFO - PROCESS | 1657 | RSS: Main: 219148288 09:00:49 INFO - PROCESS | 1657 | 09:00:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:53 INFO - PROCESS | 1657 | RSS: Main: 269602816 09:00:53 INFO - PROCESS | 1657 | 09:00:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 09:00:56 INFO - PROCESS | 1657 | RSS: Main: 281059328 09:00:56 INFO - PROCESS | 1657 | 09:00:59 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 09:01:00 INFO - PROCESS | 1657 | RSS: Main: 377384960 09:01:00 INFO - PROCESS | 1657 | 09:01:02 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 09:01:02 INFO - PROCESS | 1657 | RSS: Main: 278888448 09:01:02 INFO - PROCESS | 1657 | 09:01:04 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:01:05 INFO - PROCESS | 1657 | RSS: Main: 279728128 09:01:05 INFO - PROCESS | 1657 | 09:01:08 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:08 INFO - PROCESS | 1657 | RSS: Main: 317403136 09:01:08 INFO - PROCESS | 1657 | 09:01:11 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:12 INFO - PROCESS | 1657 | RSS: Main: 318349312 09:01:12 INFO - PROCESS | 1657 | 09:01:15 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 09:01:15 INFO - PROCESS | 1657 | RSS: Main: 318156800 09:01:15 INFO - PROCESS | 1657 | 09:01:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:17 INFO - PROCESS | 1657 | RSS: Main: 290045952 09:01:17 INFO - PROCESS | 1657 | 09:01:19 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:20 INFO - PROCESS | 1657 | RSS: Main: 296337408 09:01:20 INFO - PROCESS | 1657 | 09:01:22 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:23 INFO - PROCESS | 1657 | RSS: Main: 304054272 09:01:23 INFO - PROCESS | 1657 | 09:01:26 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:26 INFO - PROCESS | 1657 | RSS: Main: 306171904 09:01:26 INFO - PROCESS | 1657 | 09:01:29 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:30 INFO - PROCESS | 1657 | RSS: Main: 307359744 09:01:30 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 09:01:32 INFO - PROCESS | 1657 | RSS: Main: 350752768 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | __start_tp_report 09:01:32 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 09:01:32 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 09:01:32 INFO - PROCESS | 1657 | |i|pagename|runs| 09:01:32 INFO - PROCESS | 1657 | |0;ai-astar;113;113;113;111;113;113;112;113;113;112 09:01:32 INFO - PROCESS | 1657 | |1;audio-beat-detection;141;110;108;143;112;108;108;109;138;106 09:01:32 INFO - PROCESS | 1657 | |2;audio-dft;183;185;182;182;184;182;183;186;186;181 09:01:32 INFO - PROCESS | 1657 | |3;audio-fft;83;58;61;88;62;59;61;59;83;59 09:01:32 INFO - PROCESS | 1657 | |4;audio-oscillator;84;70;95;69;67;68;91;68;68;89 09:01:32 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;87;84;87;83;87;84;87;84;86;83 09:01:32 INFO - PROCESS | 1657 | |6;imaging-darkroom;93;93;92;93;95;93;93;94;93;94 09:01:32 INFO - PROCESS | 1657 | |7;imaging-desaturate;84;85;84;70;132;133;135;88;85;87 09:01:32 INFO - PROCESS | 1657 | |8;json-parse-financial;56;53;51;51;55;57;56;56;55;56 09:01:32 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;76;95;109;106;82;70;70;70;70;72 09:01:32 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;83;84;86;79;84;84;84;88;88;107 09:01:32 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;148;145;142;136;136;135;136;136;146;137 09:01:32 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;202;225;176;160;163;162;160;163;162;163 09:01:32 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;64;66;65;65;66;66;65;66;67;69 09:01:32 INFO - PROCESS | 1657 | __end_tp_report 09:01:32 INFO - PROCESS | 1657 | __start_cc_report 09:01:32 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1943 09:01:32 INFO - PROCESS | 1657 | __end_cc_report 09:01:32 INFO - PROCESS | 1657 | __startTimestamp1475164892347__endTimestamp 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | ------- Summary: start ------- 09:01:32 INFO - PROCESS | 1657 | Number of tests: 14 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 09:01:32 INFO - PROCESS | 1657 | Values: 113.0 113.0 113.0 111.0 113.0 113.0 112.0 113.0 113.0 112.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:111.00 stddev:15.56 (14.0%) stddev-sans-first:14.17 09:01:32 INFO - PROCESS | 1657 | Values: 141.0 110.0 108.0 143.0 112.0 108.0 108.0 109.0 138.0 106.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:183.40 Median:183.50 stddev:1.78 (1.0%) stddev-sans-first:1.88 09:01:32 INFO - PROCESS | 1657 | Values: 183.0 185.0 182.0 182.0 184.0 182.0 183.0 186.0 186.0 181.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:67.30 Median:61.50 stddev:12.12 (19.7%) stddev-sans-first:11.45 09:01:32 INFO - PROCESS | 1657 | Values: 83.0 58.0 61.0 88.0 62.0 59.0 61.0 59.0 83.0 59.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.00 stddev:11.40 (14.8%) stddev-sans-first:11.79 09:01:32 INFO - PROCESS | 1657 | Values: 84.0 70.0 95.0 69.0 67.0 68.0 91.0 68.0 68.0 89.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.50 stddev:1.75 (2.0%) stddev-sans-first:1.73 09:01:32 INFO - PROCESS | 1657 | Values: 87.0 84.0 87.0 83.0 87.0 84.0 87.0 84.0 86.0 83.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 09:01:32 INFO - PROCESS | 1657 | Values: 93.0 93.0 92.0 93.0 95.0 93.0 93.0 94.0 93.0 94.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:98.30 Median:84.50 stddev:24.68 (29.2%) stddev-sans-first:25.63 09:01:32 INFO - PROCESS | 1657 | Values: 84.0 85.0 84.0 70.0 132.0 133.0 135.0 88.0 85.0 87.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:56.00 stddev:2.17 (3.9%) stddev-sans-first:2.24 09:01:32 INFO - PROCESS | 1657 | Values: 56.0 53.0 51.0 51.0 55.0 57.0 56.0 56.0 55.0 56.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:82.00 Median:71.00 stddev:15.58 (22.0%) stddev-sans-first:16.38 09:01:32 INFO - PROCESS | 1657 | Values: 76.0 95.0 109.0 106.0 82.0 70.0 70.0 70.0 70.0 72.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:84.00 stddev:7.59 (9.0%) stddev-sans-first:7.93 09:01:32 INFO - PROCESS | 1657 | Values: 83.0 84.0 86.0 79.0 84.0 84.0 84.0 88.0 88.0 107.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:139.50 stddev:5.01 (3.6%) stddev-sans-first:4.32 09:01:32 INFO - PROCESS | 1657 | Values: 148.0 145.0 142.0 136.0 136.0 135.0 136.0 136.0 146.0 137.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:163.00 stddev:22.19 (13.6%) stddev-sans-first:21.02 09:01:32 INFO - PROCESS | 1657 | Values: 202.0 225.0 176.0 160.0 163.0 162.0 160.0 163.0 162.0 163.0 09:01:32 INFO - PROCESS | 1657 | 09:01:32 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.37 (2.1%) stddev-sans-first:1.27 09:01:32 INFO - PROCESS | 1657 | Values: 64.0 66.0 65.0 65.0 66.0 66.0 65.0 66.0 67.0 69.0 09:01:32 INFO - PROCESS | 1657 | -------- Summary: end -------- 09:01:32 INFO - PROCESS | 1657 | 09:01:33 INFO - TEST-INFO | 1657: exit 0 09:01:33 INFO - TEST-OK | kraken | took 58859ms 09:01:33 INFO - SUITE-END | took 1175s 09:01:33 INFO - Completed test suite (00:19:36) 09:01:33 INFO - javascript benchmark 09:01:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3297.967020329797, 3324.135724711575, 3355.1779813945586, 3356.2784001439686, 3396.23584693444, 5701.0, 5778.65328080315, 5778.768849246036, 5794.0, 5830.795922142721, 5712.800051998181, 5772.076467765159, 5784.56615753818, 5787.305523337195, 5791.884162316751, 5231.65994210377, 5274.129768588197, 5286.31277933868, 5297.973510132444, 5331.280277162592, 5205.713685747282, 5227.5295223429885, 5238.633295669305, 5363.597730170233, 5400.864978375533, 5311.176767601028, 5320.893582128355, 5339.439358867321, 5344.652597581165, 5346.224797404374, 5218.843434696965, 5256.579473642099, 5278.868028299304, 5283.339582552181, 5310.150375939869, 5205.791768329263, 5220.269162317279, 5296.417394086648, 5303.0, 5304.708241046741, 5581.441855814427, 5633.0987042073075, 5750.0224961756185, 5757.280339957505, 5821.388754180834, 6145.555794388315, 6172.969135154295, 6208.441240288351, 6208.596441231305, 6238.1578486904145, 6271.717772700239, 6306.810795676137, 6314.810555683291, 6363.93636063638, 6372.0, 5678.0, 5834.329052159013, 5851.0, 5858.974679431082, 5891.086881533369, 6226.501879849601, 6270.216222972129, 6321.936780632135, 6330.8417289567205, 6361.9045714314325, 6213.96893015532, 6220.315765265817, 6220.564560480723, 6224.035274532454, 6236.563440559117, 6299.622022678654, 6317.368263173646, 6323.146375239376, 6332.303446620868, 6332.430081292614, 6093.451589356979, 6097.3292937776805, 6134.191047936786, 6137.2310028573, 6182.258129024546, 6296.811095667137, 6297.937020629826, 6299.307076221612, 6300.747970081237, 6302.306746257908, 4904.0, 4935.3090567320605, 4938.012397520511, 4952.90094198114, 4961.603071754251, 4357.324614684729, 4383.452068491439, 4430.313301438282, 4470.97167651442, 4475.641948644101, 5667.1499275108235, 5752.798652047159, 5764.855878602984, 5774.509166720792, 5776.595638305363, 6330.050492426173, 6335.366463353628, 6353.396427339396, 6356.396142366468, 6356.618602883842, 5746.109353050284, 5752.712364381764, 5778.422157784188, 5781.624194427349, 5831.708414579254, 5350.91973620396, 5358.54452371545, 5365.597580181502, 5387.24578559002, 5413.702246376487, 6287.1198032275515, 6357.0, 6357.14178585885, 6368.458681011981, 6373.330800265905, 6229.844253893689, 6364.904526432199, 6365.681715914093, 6375.330590287953, 6376.553641245068, 6281.277653069773, 6335.3981371769605, 6348.619082855043, 6355.7457701693265, 6360.109584658059, 6105.419985101586, 6158.938410615837, 6177.351378105414, 6268.153799237227, 6276.340984196594, 6122.418370254819, 6342.080398342122, 6342.619442833445, 6352.333005034405, 6367.140436041075, 5922.73347699346, 5946.554008449297, 6108.57239993214, 6149.108379285068, 6166.383361663798, 5992.880142397041, 6037.124616930609, 6076.513878889767, 6077.726502307319, 6116.541259405473, 6041.305249896318, 6045.697715114139, 6045.879082418415, 6063.333033366238, 6084.361142080195, 6078.3617720138745, 6148.538859585459, 6175.197224360984, 6188.566800324114, 6189.535784816067, 4849.660523763303, 5789.594728368974, 5844.47399734009, 5980.551458640706, 6004.309504407049], "value": 5739.75739058591, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.4600690195922, 517.066694616218, 520.9374875014996, 540.6782964136339, 543.5379927061997, 30122.246943826416, 39170.804145979266, 40496.19007619846, 40531.392029119546, 42663.36004959921, 42145.15709685804, 42522.149557008845, 42586.57413425865, 42595.78702106493, 42627.36058959118, 9806.55870485828, 9970.601175952954, 9985.201183905307, 9988.650397236099, 9992.350497217658, 9830.459324737136, 9941.055599718014, 9975.102240798327, 9976.75058123549, 9977.451240181786, 9955.303128780988, 9995.90004099957, 9997.450140242283, 10012.098911097999, 10037.849432258521, 9852.408855468659, 9961.203103751683, 9968.900310996869, 9970.302078854484, 9996.350237234556, 8489.575521223915, 9809.705708828675, 9913.40519568821, 9929.50352482373, 9931.0, 39571.60428395708, 39939.8003009986, 40000.79993600505, 40040.79979600113, 40059.7997010016, 3031.7726170537076, 3394.0835974286806, 3405.6934875861293, 3492.2840817632323, 3849.942250866239, 29384.265393365124, 29458.0, 29494.85252573745, 30974.0, 31791.205219869687, 3072.293372524332, 3100.3954228925368, 3142.418652549263, 3285.3100848821778, 3295.0938491914917, 509661.0, 509980.0, 515707.421462894, 516155.0, 518651.0, 60371.0, 60933.78132437327, 60938.0, 60940.0, 61071.08393374103, 34209.0, 34694.30611387758, 34779.652203478145, 36049.639503605154, 36081.8195909024, 17114.572135696457, 17321.826781732274, 17323.960562366046, 17331.133443327784, 17344.91327543354, 13186.670333241746, 13299.734005319839, 13315.267660278778, 13324.933375333256, 13331.933340333237, 18912.0, 18945.957972311655, 18948.43154705361, 18970.90514547446, 18976.0, 6747.0, 7974.202579741979, 8079.272865442138, 8134.511929284262, 8136.593170341459, 834.4367551902442, 900.3247564326755, 901.5987885391069, 936.391345625349, 1154.0421450196318, 24178.0, 28939.0, 29604.0, 29931.0, 30343.544846827313, 757.2238455583072, 901.2654686430539, 1093.4040947683532, 1121.8205087186175, 1135.7444574970566, 11128.443577821077, 16023.038617682976, 16217.108059056865, 16325.26536305869, 16827.74758378625, 670134.0, 672568.0, 672653.0, 672968.0, 674603.0, 56792.14811777827, 57276.713616432484, 57463.56341091506, 57567.712161438925, 57595.0, 1235.2279825109306, 1266.9303188324545, 1316.55895275082, 1359.5717349035021, 1399.6151058458597, 28053.43893122085, 28700.282492937844, 29746.553801693426, 29926.401471970003, 30419.847900760353, 47320.763396182796, 47949.520504794506, 48070.0, 48098.0, 48120.7593962028, 546133.0, 551777.0, 552837.0, 662863.0, 666578.0, 40811.38782918199, 41140.382894256014, 41385.37921931113, 41423.37864931968, 41658.79170604127, 39317.6068239314, 43932.78033609811, 45303.77348113238, 45752.771236143606, 46038.849028773206, 36505.45241821428, 37012.44481332728, 38139.42790858084, 39118.60881391264, 39157.804210978764, 37335.0, 37970.8101459502, 38115.80942095272, 38164.618353816106, 39215.803920980215, 36564.0, 37455.81272093622, 37675.246495070496, 37894.621053790215, 37969.24061518809, 30182.943596974, 31416.68583314229, 32703.018909432754, 33081.50377744384, 33962.49056264207, 24655.50688986246, 24865.254042378758, 25104.874475627505, 25142.49715005653, 25696.614550782127], "value": 19888.378399956655, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.6245654692932, 348.05503059194314, 369.3554746966543, 373.0915221435804, 381.4811855876009, 15063.698726025474, 15284.465043723472, 18794.43616691498, 21108.472288192763, 21137.894310528427, 19662.0, 20733.68899466509, 20953.952302384896, 20955.266565670205, 20996.580068398624, 5897.675627840467, 6138.815835524919, 6157.538184636148, 6164.445199932005, 6164.7534098636, 4094.9385759213637, 4362.585554372329, 6886.621235832027, 6935.375816176543, 6964.4080253178545, 6556.770513032045, 6774.559653622498, 6898.413634841045, 6914.412274956635, 6917.481188910827, 6685.4985876059, 6745.898811517831, 6801.761938332159, 6838.692258848364, 6842.52102352838, 5645.520130788888, 5815.331236907768, 5873.0, 5883.058710606325, 5887.558433117533, 24723.752762472326, 25211.747882521122, 25288.747112529007, 25447.491050179076, 25681.871590642113, 2252.526969336441, 2337.100216416675, 2409.1808785013004, 2838.6025956366125, 3180.173154979722, 14709.632259193499, 15760.842391576052, 15973.840261597352, 15981.0, 16203.918980405022, 1815.8638102142393, 1908.1222637586588, 1908.6659834528903, 1933.1397528100001, 1961.9607607847763, 113528.0, 117317.41341293324, 117512.0, 118050.81949180484, 128347.0, 11334.489947952361, 11531.538738450536, 11671.824922626167, 11755.353455560027, 11895.799277133758, 14635.121892686473, 14664.046836955564, 14664.926675366769, 14675.486357977634, 14680.04579702316, 8467.83064338722, 8597.441166324168, 8629.654813807503, 8658.956705216433, 8755.605997730117, 8600.655973760979, 8638.827223455495, 8654.697085601974, 8744.0, 8751.431156974777, 4513.842015529441, 4527.592516673515, 4547.0, 4560.5895469407915, 4608.723476591415, 1895.753532064508, 1915.6456055629474, 1916.4154932745646, 1917.1277068933603, 1942.4464027752024, 825.145973917005, 905.8892779822996, 922.8385032619265, 930.4045410937006, 980.3774603127066, 17478.0, 20025.599488010157, 21344.893275533523, 21517.56964860694, 21559.784402156092, 839.4207996482407, 914.6752902719572, 924.6209054287709, 934.5000424772714, 951.3007939164709, 8752.862127923328, 10464.424456654804, 11154.0, 11159.888401115884, 11172.720681983015, 583727.0, 604326.0, 607051.0, 616191.0, 623158.0, 74872.25127748762, 75730.0, 77282.61358693171, 126419.31113099933, 132683.0, 944.2681921510884, 952.6046690623314, 953.9379940303719, 973.3089506450499, 974.1670871404989, 18321.633567328845, 18915.90542047281, 19477.51306217356, 19513.024348782787, 19547.0, 53044.0, 56388.71805640945, 57981.0, 58111.0, 58834.0, 79932.60033699794, 81601.59199203966, 84693.0, 85548.14451855402, 86589.56705216433, 8019.438639295194, 8035.919640803517, 8043.6782528698195, 8058.153893841297, 8238.794030149294, 8943.418677785923, 12736.554220602235, 12997.870021300045, 13244.867551324363, 13323.733525329246, 10752.946235268773, 10948.671539853816, 11275.210735248455, 11326.37704926204, 11565.241296578477, 9227.44635321883, 10962.397068161008, 10967.561297548009, 11093.00162985303, 11163.832542512031, 11204.0, 11218.214724969173, 11372.260803047775, 11404.372759498307, 11532.25040372373, 7822.374210063295, 8009.719659812112, 8166.918330816616, 8189.262966333059, 8370.623321950405, 10292.330998485075, 11041.834372484258, 11273.943630281796, 11380.772384552429, 11531.769364612828], "value": 9740.437066683291, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1535.470262759348, 1544.5366390082975, 1612.459825958304, 1855.5268406556327, 1861.6649003179423, 8519.574021298933, 9014.684486042974, 9027.142421469965, 9028.54857257137, 9037.0, 7137.892931606017, 7869.2130786921425, 8124.512529248249, 8814.986276578196, 8829.514376709278, 2407.325948734353, 2447.486027934136, 2447.79193768529, 2447.9388015299583, 2448.7511369201748, 2414.1188466209883, 2420.1408499982517, 2454.8772561371948, 2455.2388759484616, 2458.0045081741923, 2425.6967879015124, 2439.0365805506813, 2442.0, 2448.804095672342, 2449.35092200567, 2395.5089206712582, 2403.51929614077, 2410.011895123009, 2415.4444477770035, 2419.11702228687, 2413.095089341497, 2420.189236605739, 2423.6243382275597, 2428.9757102428925, 2430.635404689293, 8841.336899732545, 8943.686970955985, 8977.371583989123, 9022.639094436214, 9043.954780226057, 5275.86810329741, 5458.781648734046, 5459.645123067027, 5464.808731694411, 5467.58993075517, 3450.603180634234, 3589.6410358964154, 3639.217568222845, 3655.342038433081, 3682.558093028827, 1072.554889720765, 1095.802755504009, 1107.8393632923262, 1120.5685810962757, 1125.5047778977223, 10337.966203379678, 11670.649880503599, 11789.410529473578, 11820.822687659605, 11870.109741769402, 4373.781310934441, 4583.381243532147, 4890.657653964259, 4910.754462276872, 4917.532834380728, 10077.0, 10080.899191008142, 10087.69736907894, 10095.091441770275, 10101.898981010096, 5433.701146436905, 5439.347278326626, 5445.210444485607, 5446.2375267462585, 5453.072977593819, 4456.487503937024, 4610.95389046112, 4756.476787553366, 4951.851444456672, 4972.378452693413, 3959.247742928834, 3989.401589761501, 4101.0, 4129.132882094734, 4134.1731653669385, 1297.5134324628264, 1317.953871614508, 1319.4919955816888, 1330.5409633676366, 1331.0, 807.2815194476921, 907.6641642592283, 912.261068534476, 931.362017018331, 934.7008957133788, 5766.481016708516, 5768.163616275617, 5858.560607954335, 5994.9700251499335, 6139.324674285825, 450.70929250633156, 454.01478791023555, 461.0157314134347, 1013.1287093099928, 1023.4064242739194, 3979.442877997025, 4019.6784257259933, 4028.8388464461677, 4161.9375709364385, 4194.454720886265, 10643.41461219625, 11027.61403350879, 11028.834567481494, 11030.952059554329, 11043.282186658002, 10824.621138260281, 10968.835467467994, 10995.670129895956, 10995.725106872393, 11013.559457621766, 7454.664540095709, 8207.712730054538, 8369.288610468057, 8375.371847111492, 8391.748247552461, 5137.845864624067, 5804.100364443518, 5814.680192589279, 5929.0, 6088.178095956989, 7658.770236892902, 10325.277230594087, 10410.947945260225, 10416.739581510523, 10423.0, 9901.306908516335, 10286.588536458457, 10357.585696572354, 10499.475026248505, 10506.159507239556, 7062.1878483975, 7298.890516642148, 7406.518576292524, 7514.511556748794, 7745.612719363897, 8393.160683931557, 8588.957055214683, 8597.828043439222, 8609.440386374865, 8615.439996400213, 7423.814404639711, 7460.142083660448, 7544.660490277841, 7620.1998790128455, 7706.190849960898, 7317.26827317264, 7476.962615186889, 7503.09962804467, 7648.158702542827, 7707.576083315472, 6163.691815409301, 7082.645867706698, 7256.4194864411775, 7259.366642505394, 7295.927040729524, 4963.255511673278, 5051.722155281494, 5115.232715092766, 5125.589952803842, 5157.458466860926, 5001.524855138756, 5060.696358218519, 5187.403448603308, 5195.142801437721, 5226.947730522646], "value": 4621.18632924679, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.227807950686, 305.13189974522487, 309.7166093024882, 315.97472202223827, 318.55402436588787, 3793.184465339951, 4452.821887124515, 5300.257963885059, 5331.413544510106, 5356.00977271932, 4869.297539865373, 5107.3871135463705, 5227.4511176326505, 5298.403782146749, 5340.572754179666, 4074.0, 4082.6121518455698, 4091.9590804092027, 4119.958800411988, 4120.958790412095, 3933.718443302892, 3951.486306780115, 4112.403701463286, 4120.3201471757275, 4121.608447197526, 3323.9501407478906, 3328.6019871653843, 3524.400851855191, 4038.172174704179, 4066.755994640331, 3217.1796191971016, 3666.578343490506, 4031.3952907064026, 4068.9796551017353, 4069.5930406959365, 3092.2528771244174, 3300.224447254893, 3477.687008169277, 3523.9119022024397, 3565.625609311011, 4214.0, 4498.032922921555, 4757.738324392157, 5042.546170844605, 5150.175971844525, 4549.931751023737, 4553.726776393427, 4560.452745670507, 4571.291449825282, 4595.471520775121, 5039.933627212862, 5409.891802163935, 5489.615726899118, 5602.971985140089, 5624.859378515529, 3745.8721967157458, 3796.2597293527774, 3806.809659517041, 3807.447920051577, 3821.445890345912, 5271.441776800682, 5563.0, 5873.207117039187, 5882.352941176498, 5911.728978269693, 3022.5466180072726, 3758.248350329945, 3852.556955950102, 3852.8651497197466, 3856.7878766668105, 3415.880444184442, 3941.704372172041, 3945.6448919597374, 3946.2699400610977, 3967.8412863485714, 4561.178987782231, 4574.5425457453985, 4590.219662657356, 4598.770061496979, 4633.772050406645, 5432.158015507603, 5618.943810561924, 5651.106879195433, 5653.0, 5669.234653321749, 1193.373478923572, 1200.2498438475952, 1310.8661008227814, 1327.7875539913568, 1346.501794336102, 690.3648643248224, 803.7588723383078, 812.3257696112213, 816.9135050382977, 819.2094628683349, 3854.6530812227033, 4089.7955102245364, 4093.5497095319492, 4188.28799104153, 4371.617468479686, 4102.835886564564, 4255.659547236213, 4386.407834942306, 4702.811887524461, 4812.590929770939, 4196.307609244441, 4389.122175564899, 4408.955910440919, 4426.251630605892, 4428.250840917819, 2248.820094392445, 2404.7835694787555, 2425.3815277104577, 2495.8752062396807, 2511.962320565193, 4555.175791009529, 4622.583967442946, 4826.918083215174, 4853.635977301717, 4896.3352460163715, 4280.5505421930875, 4345.478542574848, 4641.303804429363, 4916.631252656065, 5030.949690503048, 3890.0469385000856, 4058.228936502055, 4397.868063958086, 5007.499250075036, 5008.474110218447, 4725.10223057618, 4749.430068391815, 4755.976220118877, 4821.807127714852, 4894.559489645949, 4528.954710452853, 4677.555632214934, 4705.67060305789, 4711.78796954131, 4816.277558366133, 4594.264917613166, 4996.3504744383, 5078.296648424045, 6021.698915054142, 6038.788642397495, 3262.706356427933, 3635.5092062571216, 3776.4524143999515, 3779.4519794629073, 3909.139989202371, 4851.320815085962, 5711.742971566373, 5842.532597392284, 5869.236999190078, 5886.793962211302, 4716.410448693913, 5691.288588926384, 5698.344690360662, 5699.8860022800145, 5703.344115426779, 4727.739974301447, 5224.7126408047925, 5297.860959893641, 5633.63381380209, 5692.829215123553, 5093.981203759337, 5579.497845193952, 5588.636738611977, 5593.188987596857, 5594.692291923983, 5347.117725575236, 5660.405657405913, 5671.943280567141, 5686.573506987075, 5696.499765185457, 4579.62611216627, 5180.378354597472, 5500.469783899451, 5551.306086739158, 5568.9443105568425], "value": 3857.501749828885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.9784306470806, 808.6320724070548, 808.8058865872189, 819.8729196974471, 820.3232333325006, 14957.925210373947, 15868.206589670513, 15905.125218112998, 15906.284217210225, 15915.283812228448, 15456.0, 15552.53342399727, 15587.688246235068, 16394.508164755076, 16410.17949102546, 666.8366250268667, 683.7367613468825, 707.9185893622248, 840.1430540848346, 865.0138841720412, 684.3464491410691, 833.1585099049943, 843.1905370843966, 858.7509622209552, 861.2205953611959, 898.1467605774508, 898.74385800047, 900.522722956834, 900.5542256583001, 901.8151278987792, 695.0373732380639, 891.585412783059, 892.7589550821274, 893.2318206342541, 893.3121496447699, 531.0070168784398, 534.0973754355127, 534.1293691283183, 534.6925517827265, 645.5803727577065, 15338.0, 15676.137812420313, 15683.137427441487, 15695.529134125994, 15697.764533532007, 11474.426278686116, 13573.0, 13713.931430342784, 13849.099808512414, 13863.861361386358, 11477.253978491455, 11953.46209420578, 11999.220050696676, 12616.306103164323, 12997.285149316784, 3849.076221706798, 3901.7854018028997, 3961.6830653547645, 3998.4402183694306, 4002.0995276062945, 111727.0, 111790.44104779424, 112533.0, 112838.0, 114460.42769786097, 10586.947065264778, 10883.619073332395, 10994.835077473845, 11060.778784424267, 11360.715982100348, 21884.23405180811, 21946.231881884058, 22047.0, 22048.88975555112, 22105.66841497379, 7901.644426000728, 7928.365730741642, 7940.841183176304, 7973.840523189504, 8025.799355016171, 4272.273713468718, 4298.290782020931, 4337.9783101084295, 4402.207602631557, 4420.425344705168, 3464.6535346465153, 3638.9636103639154, 3640.4357324614725, 3640.635936406391, 3641.126129728899, 626.8683576448906, 655.0665301944709, 663.2770280394296, 668.2949488289804, 669.7254125808493, 514.282575806755, 602.3554796367932, 606.6026752477135, 625.0280813335216, 630.5649102119523, 8514.914850851535, 9206.401583897159, 9266.490343031199, 9410.153086222135, 9410.917744459475, 427.3952357414286, 526.6076772804286, 585.7217821534737, 589.0898561722149, 593.4273426143792, 4429.734215947054, 4499.820007199675, 4527.366168736379, 4529.501754806968, 4603.217453032926, 174034.0, 176177.0, 180165.0991745033, 184792.0, 188270.0, 143710.0, 148332.0, 148572.0, 154107.0, 155406.4526451056, 113523.0, 123372.0, 124367.0, 128305.35847320891, 128396.71603284034, 8454.154584541497, 8776.736697899074, 8830.072842351718, 8861.335399845166, 8959.41763785352, 68426.31573684199, 69025.0, 69937.65031174812, 70481.0, 71423.0, 101969.0, 106428.0, 108351.0, 110829.0, 111150.44424777824, 11616.709582260512, 11680.415979200836, 11822.40887955616, 12112.273263604213, 12135.0, 10756.354618722902, 12133.029357651543, 12243.938780306398, 12395.62813115608, 12834.807477888025, 13116.803247951097, 13574.253416061816, 14026.420683279839, 14652.633684157981, 14882.0, 13548.796768048684, 13650.313636839755, 13754.0, 14144.646383840487, 14732.852671473149, 13441.529546465827, 13466.49355837427, 13647.249401283025, 13703.657408564866, 13888.513902013381, 11255.96058331938, 11427.485763140512, 11704.239224450383, 11761.176717629683, 12190.146689731633, 10597.682069537927, 10978.505967231653, 11763.47064382122, 11850.407479625812, 12026.518939242682], "value": 7867.765393825652, "unit": "score"}], "name": "dromaeo_css", "value": 7336.774538266243, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 111.0, 113.0, 113.0, 112.0, 113.0, 113.0, 112.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 108.0, 143.0, 112.0, 108.0, 108.0, 109.0, 138.0, 106.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 182.0, 182.0, 184.0, 182.0, 183.0, 186.0, 186.0, 181.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 61.0, 88.0, 62.0, 59.0, 61.0, 59.0, 83.0, 59.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 95.0, 69.0, 67.0, 68.0, 91.0, 68.0, 68.0, 89.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 83.0, 87.0, 84.0, 87.0, 84.0, 86.0, 83.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 92.0, 93.0, 95.0, 93.0, 93.0, 94.0, 93.0, 94.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 70.0, 132.0, 133.0, 135.0, 88.0, 85.0, 87.0], "value": 98.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 51.0, 51.0, 55.0, 57.0, 56.0, 56.0, 55.0, 56.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 95.0, 109.0, 106.0, 82.0, 70.0, 70.0, 70.0, 70.0, 72.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 86.0, 79.0, 84.0, 84.0, 84.0, 88.0, 88.0, 107.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 142.0, 136.0, 136.0, 135.0, 136.0, 136.0, 146.0, 137.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 225.0, 176.0, 160.0, 163.0, 162.0, 160.0, 163.0, 162.0, 163.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 66.0, 66.0, 65.0, 66.0, 67.0, 69.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1437.8, "alertThreshold": 2.0}]} 09:01:33 INFO - Return code: 0 09:01:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:33 INFO - # TBPL SUCCESS # 09:01:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:01:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:01:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:01:33 INFO - 2016-09-29 09:01:33.662 screenresolution[1661:9953] starting screenresolution argv=screenresolution get 09:01:33 INFO - 2016-09-29 09:01:33.665 screenresolution[1661:9953] Display 0: 1600x1200x32@60 09:01:33 INFO - 2016-09-29 09:01:33.671 screenresolution[1662:9956] starting screenresolution argv=screenresolution list 09:01:33 INFO - Available Modes on Display 0 09:01:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:01:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:01:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:01:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:01:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:01:33 INFO - Intel Iris: 09:01:33 INFO - Chipset Model: Intel Iris 09:01:33 INFO - Type: GPU 09:01:33 INFO - Bus: Built-In 09:01:33 INFO - VRAM (Dynamic, Max): 1536 MB 09:01:33 INFO - Vendor: Intel (0x8086) 09:01:33 INFO - Device ID: 0x0a2e 09:01:33 INFO - Revision ID: 0x0009 09:01:33 INFO - Displays: 09:01:33 INFO - Display: 09:01:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:01:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:01:33 INFO - Display Serial Number: 1600x1200 60 09:01:33 INFO - Main Display: Yes 09:01:33 INFO - Mirror: Off 09:01:33 INFO - Online: Yes 09:01:33 INFO - Rotation: Supported 09:01:33 INFO - Return code: 0 09:01:33 INFO - Running post-action listener: _resource_record_post_action 09:01:33 INFO - [mozharness: 2016-09-29 16:01:33.912273Z] Finished run-tests step (success) 09:01:33 INFO - Running post-run listener: _resource_record_post_run 09:01:33 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 37331968; Write bytes: 662306304; Read time: 242; Write time: 1857 09:01:33 INFO - TinderboxPrint: CPU usage
53.4% 09:01:33 INFO - TinderboxPrint: I/O read bytes / time
37,331,968 / 242 09:01:33 INFO - TinderboxPrint: I/O write bytes / time
662,306,304 / 1,857 09:01:33 INFO - TinderboxPrint: CPU idle
2,253.9 (46.6%) 09:01:33 INFO - TinderboxPrint: CPU system
965.2 (20.0%) 09:01:33 INFO - TinderboxPrint: CPU user
1,618.5 (33.5%) 09:01:33 INFO - TinderboxPrint: Swap in / out
400,310,272 / 0 09:01:33 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 356026880; Write bytes: 355776000; Read time: 27195; Write time: 708 09:01:33 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 35529728; Write bytes: 295512064; Read time: 226; Write time: 1113 09:01:34 INFO - Running post-run listener: _upload_blobber_files 09:01:34 INFO - Blob upload gear active. 09:01:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:01:34 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'] 09:01:34 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 09:01:34 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:35 INFO - (blobuploader) - INFO - Done attempting. 09:01:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:01:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:36 INFO - (blobuploader) - INFO - Done attempting. 09:01:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:39 INFO - (blobuploader) - INFO - Done attempting. 09:01:39 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:39 INFO - Return code: 0 09:01:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/295618a6f8dda2bfde08dc3ce8aa60f80ad8bad6766d8351154586c93db5f1c89305fc9cee3ebeede63f6ce5f439f11e22c1cf60411f7cba888f700f95f05c96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e77408818ec4246a83bc0f3177a57320fcedf70be33e476e9fa872bb5830530f1a099dc8a1b74b04eabf89a7e0c69550b64edd893bac82b8f7d480f9ec3c0201", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68e845f0e971054d195f0df7a6c1e952c914eeab2640f3dc1ce17bd89024ba0440aecc1c72361354023496ba39a4f979c759b9a51450029409a2325317cbd970"} 09:01:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:39 INFO - Contents: 09:01:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/295618a6f8dda2bfde08dc3ce8aa60f80ad8bad6766d8351154586c93db5f1c89305fc9cee3ebeede63f6ce5f439f11e22c1cf60411f7cba888f700f95f05c96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e77408818ec4246a83bc0f3177a57320fcedf70be33e476e9fa872bb5830530f1a099dc8a1b74b04eabf89a7e0c69550b64edd893bac82b8f7d480f9ec3c0201", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68e845f0e971054d195f0df7a6c1e952c914eeab2640f3dc1ce17bd89024ba0440aecc1c72361354023496ba39a4f979c759b9a51450029409a2325317cbd970"} 09:01:39 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:39 INFO - Copying logs to upload dir... 09:01:39 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.703432 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-29 09:01:39.441137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 09:01:39.444249) ========= 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.GGFcorvvrb/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.evHZCqPLFH/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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/295618a6f8dda2bfde08dc3ce8aa60f80ad8bad6766d8351154586c93db5f1c89305fc9cee3ebeede63f6ce5f439f11e22c1cf60411f7cba888f700f95f05c96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e77408818ec4246a83bc0f3177a57320fcedf70be33e476e9fa872bb5830530f1a099dc8a1b74b04eabf89a7e0c69550b64edd893bac82b8f7d480f9ec3c0201", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68e845f0e971054d195f0df7a6c1e952c914eeab2640f3dc1ce17bd89024ba0440aecc1c72361354023496ba39a4f979c759b9a51450029409a2325317cbd970"} build_url:https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011208 build_url: 'https://queue.taskcluster.net/v1/task/XP9LSSbvR7muBTUHG46zNA/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/295618a6f8dda2bfde08dc3ce8aa60f80ad8bad6766d8351154586c93db5f1c89305fc9cee3ebeede63f6ce5f439f11e22c1cf60411f7cba888f700f95f05c96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e77408818ec4246a83bc0f3177a57320fcedf70be33e476e9fa872bb5830530f1a099dc8a1b74b04eabf89a7e0c69550b64edd893bac82b8f7d480f9ec3c0201", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/68e845f0e971054d195f0df7a6c1e952c914eeab2640f3dc1ce17bd89024ba0440aecc1c72361354023496ba39a4f979c759b9a51450029409a2325317cbd970"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 09:01:39.480650) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:01:39.481395) ========= 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.GGFcorvvrb/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.evHZCqPLFH/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.005186 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 09:01:39.534302) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 09:01:39.535014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 09:01:39.535674) ========= ========= Total master_lag: 0.19 =========