builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0036 starttime: 1487360883.65 results: success (0) buildid: 20170217110819 builduid: d134880e8ae64111948777b4fe6cddc8 revision: db2e6ff03ae1c57ebd4b4dae874d744bd1b8a41b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:03.649727) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:03.650218) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:03.650521) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:03.684766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:03.685186) ========= 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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 --2017-02-17 11:48:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.8M=0.001s 2017-02-17 11:48:03 (16.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.178801 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:03.892711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:03.893115) ========= 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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.026613 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:03.942243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 11:48:03.945674) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev db2e6ff03ae1c57ebd4b4dae874d744bd1b8a41b --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 db2e6ff03ae1c57ebd4b4dae874d744bd1b8a41b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 2017-02-17 11:48:04,051 truncating revision to first 12 chars 2017-02-17 11:48:04,051 Setting DEBUG logging. 2017-02-17 11:48:04,051 attempt 1/10 2017-02-17 11:48:04,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/db2e6ff03ae1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-17 11:48:04,768 unpacking tar archive at: mozilla-aurora-db2e6ff03ae1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.979470 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 11:48:04.981908) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:04.982228) ========= script_repo_revision: db2e6ff03ae1c57ebd4b4dae874d744bd1b8a41b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:04.982670) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:04.982949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 11:48:05.006793) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-02-17 11:48:05.007151) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 11:48:05 INFO - MultiFileLogger online at 20170217 11:48:05 in /builds/slave/test 11:48:05 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 11:48:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:48:05 INFO - {'append_to_log': False, 11:48:05 INFO - 'base_work_dir': '/builds/slave/test', 11:48:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:48:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:48:05 INFO - 'branch': 'Mozilla-Aurora', 11:48:05 INFO - 'buildbot_json_path': 'buildprops.json', 11:48:05 INFO - 'config_files': ('talos/mac_config.py',), 11:48:05 INFO - 'default_actions': ('clobber', 11:48:05 INFO - 'read-buildbot-config', 11:48:05 INFO - 'download-and-extract', 11:48:05 INFO - 'populate-webroot', 11:48:05 INFO - 'create-virtualenv', 11:48:05 INFO - 'install', 11:48:05 INFO - 'run-tests'), 11:48:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:48:05 INFO - 'download_minidump_stackwalk': True, 11:48:05 INFO - 'download_symbols': 'ondemand', 11:48:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:48:05 INFO - 'tooltool.py': '/tools/tooltool.py', 11:48:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:48:05 INFO - '/tools/misc-python/virtualenv.py')}, 11:48:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:48:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:48:05 INFO - 'installer_path': 'installer.exe', 11:48:05 INFO - 'log_level': 'info', 11:48:05 INFO - 'log_name': 'talos', 11:48:05 INFO - 'log_to_console': True, 11:48:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:48:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:48:05 INFO - 'opt_config_files': (), 11:48:05 INFO - 'pip_index': False, 11:48:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:48:05 INFO - 'cmd': ('bash', 11:48:05 INFO - '-c', 11:48:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:48:05 INFO - 'enabled': True, 11:48:05 INFO - 'halt_on_failure': False, 11:48:05 INFO - 'name': 'check_screen_resolution'},), 11:48:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:48:05 INFO - 'cmd': ('bash', 11:48:05 INFO - '-c', 11:48:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:48:05 INFO - 'enabled': True, 11:48:05 INFO - 'halt_on_failure': False, 11:48:05 INFO - 'name': 'check_screen_resolution'},), 11:48:05 INFO - 'run_cmd_checks_enabled': True, 11:48:05 INFO - 'sps_profile': False, 11:48:05 INFO - 'sps_profile_interval': 0, 11:48:05 INFO - 'suite': 'dromaeojs', 11:48:05 INFO - 'system_bits': '32', 11:48:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:48:05 INFO - 'title': 't-yosemite-r7-0036', 11:48:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:48:05 INFO - 'use_talos_json': True, 11:48:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:48:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:48:05 INFO - 'work_dir': 'build'} 11:48:05 INFO - [mozharness: 2017-02-17 19:48:05.227410Z] Running clobber step. 11:48:05 INFO - Running pre-action listener: _resource_record_pre_action 11:48:05 INFO - Running main action method: clobber 11:48:05 INFO - rmtree: /builds/slave/test/build 11:48:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:48:07 INFO - Running post-action listener: _resource_record_post_action 11:48:07 INFO - [mozharness: 2017-02-17 19:48:07.720766Z] Finished clobber step (success) 11:48:07 INFO - [mozharness: 2017-02-17 19:48:07.720907Z] Running read-buildbot-config step. 11:48:07 INFO - Running pre-action listener: _resource_record_pre_action 11:48:07 INFO - Running main action method: read_buildbot_config 11:48:07 INFO - Using buildbot properties: 11:48:07 INFO - { 11:48:07 INFO - "project": "", 11:48:07 INFO - "product": "firefox", 11:48:07 INFO - "script_repo_revision": "production", 11:48:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 11:48:07 INFO - "repository": "", 11:48:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 11:48:07 INFO - "buildid": "20170217110819", 11:48:07 INFO - "pgo_build": "False", 11:48:07 INFO - "basedir": "/builds/slave/test", 11:48:07 INFO - "buildnumber": 50, 11:48:07 INFO - "slavename": "t-yosemite-r7-0036", 11:48:07 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 11:48:07 INFO - "platform": "yosemite_r7", 11:48:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 11:48:07 INFO - "branch": "mozilla-aurora", 11:48:07 INFO - "repo_path": "releases/mozilla-aurora", 11:48:07 INFO - "revision": "db2e6ff03ae1c57ebd4b4dae874d744bd1b8a41b", 11:48:07 INFO - "stage_platform": "macosx64", 11:48:07 INFO - "builduid": "d134880e8ae64111948777b4fe6cddc8", 11:48:07 INFO - "slavebuilddir": "test" 11:48:07 INFO - } 11:48:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 11:48:07 INFO - Running post-action listener: _resource_record_post_action 11:48:07 INFO - [mozharness: 2017-02-17 19:48:07.724279Z] Finished read-buildbot-config step (success) 11:48:07 INFO - [mozharness: 2017-02-17 19:48:07.724394Z] Running download-and-extract step. 11:48:07 INFO - Running pre-action listener: _resource_record_pre_action 11:48:07 INFO - Running main action method: download_and_extract 11:48:07 INFO - mkdir: /builds/slave/test/build/tests 11:48: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')]} 11:48:07 INFO - trying https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 11:48:07 INFO - Downloading https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 11:48:09 INFO - Downloaded 1199 bytes. 11:48:09 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 11:48:09 INFO - Using the following test package requirements: 11:48:09 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:48:09 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:48:09 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 11:48:09 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:48:09 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 11:48:09 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:48:09 INFO - u'jsshell-mac.zip'], 11:48:09 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:48:09 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 11:48:09 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 11:48:09 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:48:09 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 11:48:09 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:48:09 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 11:48:09 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:48:09 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 11:48:09 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 11:48:09 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 11:48:09 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 11:48:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:48:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:48:09 INFO - Fetch https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:48:10 INFO - Expected file size: 16358451 11:48:10 INFO - Obtained file size: 16358451 11:48:17 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 11:48:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 11:48:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 11:48:17 INFO - Fetch https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 11:48:18 INFO - Expected file size: 16358451 11:48:18 INFO - Obtained file size: 16358451 11:48:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 11:48:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 11:48:24 INFO - Fetch https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 11:48:26 INFO - Expected file size: 14403485 11:48:26 INFO - Obtained file size: 14403485 11:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:26 INFO - trying https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:48:26 INFO - Downloading https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 11:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 11:48:29 INFO - Downloaded 73951372 bytes. 11:48:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:48:29 INFO - mkdir: /builds/slave/test/properties 11:48:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:48:29 INFO - Writing to file /builds/slave/test/properties/build_url 11:48:29 INFO - Contents: 11:48:29 INFO - build_url:https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 11:48:31 INFO - Running post-action listener: _resource_record_post_action 11:48:31 INFO - Running post-action listener: set_extra_try_arguments 11:48:31 INFO - [mozharness: 2017-02-17 19:48:31.094398Z] Finished download-and-extract step (success) 11:48:31 INFO - [mozharness: 2017-02-17 19:48:31.094519Z] Running populate-webroot step. 11:48:31 INFO - Running pre-action listener: _resource_record_pre_action 11:48:31 INFO - Running main action method: populate_webroot 11:48:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:48:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:48:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:48:31 INFO - '--tppagecycles', 11:48:31 INFO - '7'], 11:48:31 INFO - 'tests': ['tsvgm']}}, 11:48:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:48:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:48:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:48:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:48:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:48:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:48:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:48:31 INFO - 'talos_options': ['--disable-e10s'], 11:48:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:48:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:48:31 INFO - 'talos_options': ['--disable-e10s'], 11:48:31 INFO - 'tests': ['damp', 'tps']}, 11:48:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:48:31 INFO - 'tests': ['damp', 'tps']}, 11:48:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:48:31 INFO - 'tests': ['dromaeo_dom']}, 11:48:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:48:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:48:31 INFO - 'tests': ['basic_compositor_video']}, 11:48:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:48:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:48:31 INFO - 'tests': ['a11yr', 11:48:31 INFO - 'ts_paint', 11:48:31 INFO - 'tpaint', 11:48:31 INFO - 'sessionrestore', 11:48:31 INFO - 'sessionrestore_no_auto_restore', 11:48:31 INFO - 'tabpaint']}, 11:48:31 INFO - 'other-e10s': {'tests': ['a11yr', 11:48:31 INFO - 'ts_paint', 11:48:31 INFO - 'tpaint', 11:48:31 INFO - 'sessionrestore', 11:48:31 INFO - 'sessionrestore_no_auto_restore', 11:48:31 INFO - 'tabpaint']}, 11:48:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:48:31 INFO - 'ts_paint', 11:48:31 INFO - 'tpaint', 11:48:31 INFO - 'sessionrestore', 11:48:31 INFO - 'sessionrestore_no_auto_restore', 11:48:31 INFO - 'tabpaint']}, 11:48:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:48:31 INFO - 'ts_paint', 11:48:31 INFO - 'tpaint', 11:48:31 INFO - 'sessionrestore', 11:48:31 INFO - 'sessionrestore_no_auto_restore', 11:48:31 INFO - 'tabpaint']}, 11:48:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:48:31 INFO - 'tests': ['a11yr', 11:48:31 INFO - 'ts_paint', 11:48:31 INFO - 'tpaint', 11:48:31 INFO - 'sessionrestore', 11:48:31 INFO - 'sessionrestore_no_auto_restore', 11:48:31 INFO - 'tabpaint']}, 11:48:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:48:31 INFO - 'tests': ['a11yr', 11:48:31 INFO - 'ts_paint', 11:48:31 INFO - 'tpaint', 11:48:31 INFO - 'sessionrestore', 11:48:31 INFO - 'sessionrestore_no_auto_restore', 11:48:31 INFO - 'tabpaint']}, 11:48:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:48:31 INFO - 'tests': ['tsvgx', 11:48:31 INFO - 'tsvgr_opacity', 11:48:31 INFO - 'tart', 11:48:31 INFO - 'tscrollx', 11:48:31 INFO - 'cart', 11:48:31 INFO - 'tsvg_static']}, 11:48:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:48:31 INFO - 'tsvgr_opacity', 11:48:31 INFO - 'tart', 11:48:31 INFO - 'tscrollx', 11:48:31 INFO - 'cart', 11:48:31 INFO - 'tsvg_static']}, 11:48:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:48:31 INFO - 'talos_options': ['--disable-e10s'], 11:48:31 INFO - 'tests': ['tp5o']}, 11:48:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:48:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:48:31 INFO - 'talos_options': ['--disable-e10s', 11:48:31 INFO - '--xperf_path', 11:48:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:31 INFO - 'tests': ['tp5n']}, 11:48:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:48:31 INFO - 'talos_options': ['--xperf_path', 11:48:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:31 INFO - 'tests': ['tp5n']}}, 11:48:31 INFO - 'talos.zip': {'path': '', 11:48:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:48:31 INFO - Running post-action listener: _resource_record_post_action 11:48:31 INFO - [mozharness: 2017-02-17 19:48:31.112916Z] Finished populate-webroot step (success) 11:48:31 INFO - [mozharness: 2017-02-17 19:48:31.113049Z] Running create-virtualenv step. 11:48:31 INFO - Running pre-action listener: _resource_record_pre_action 11:48:31 INFO - Running main action method: create_virtualenv 11:48:31 INFO - Creating virtualenv /builds/slave/test/build/venv 11:48:31 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 11:48:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:48:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:48:31 INFO - Using real prefix '/tools/python27' 11:48:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:48:31 INFO - Installing distribute.............................................................................................................................................................................................done. 11:48:34 INFO - Installing pip.................done. 11:48:34 INFO - Return code: 0 11:48:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:48:35 INFO - Reading from file tmpfile_stdout 11:48:35 INFO - Output received: 11:48:35 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:48:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:35 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 0x10cdc7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947b5e2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cba5d30>, '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 0x10caccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb9abe8>, '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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 11:48:35 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 11:48:35 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 11:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VFdd0Cljf3/Render', 11:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:35 INFO - 'HOME': '/Users/cltbld', 11:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:35 INFO - 'LOGNAME': 'cltbld', 11:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:35 INFO - 'MOZ_NO_REMOTE': '1', 11:48:35 INFO - 'NO_EM_RESTART': '1', 11:48:35 INFO - 'PAGER': '/bin/cat', 11:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:35 INFO - 'PWD': '/builds/slave/test', 11:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:35 INFO - 'SHELL': '/bin/bash', 11:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4ZdV1cgKX/Listeners', 11:48:35 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 11:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:35 INFO - 'USER': 'cltbld', 11:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:35 INFO - 'XPC_FLAGS': '0x0', 11:48:35 INFO - 'XPC_SERVICE_NAME': '0', 11:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:35 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 11:48:35 INFO - Cleaning up... 11:48:35 INFO - Return code: 0 11:48:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:35 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 0x10cdc7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947b5e2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cba5d30>, '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 0x10caccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb9abe8>, '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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 11:48:35 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 11:48:35 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 11:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VFdd0Cljf3/Render', 11:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:35 INFO - 'HOME': '/Users/cltbld', 11:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:35 INFO - 'LOGNAME': 'cltbld', 11:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:35 INFO - 'MOZ_NO_REMOTE': '1', 11:48:35 INFO - 'NO_EM_RESTART': '1', 11:48:35 INFO - 'PAGER': '/bin/cat', 11:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:35 INFO - 'PWD': '/builds/slave/test', 11:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:35 INFO - 'SHELL': '/bin/bash', 11:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4ZdV1cgKX/Listeners', 11:48:35 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 11:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:35 INFO - 'USER': 'cltbld', 11:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:35 INFO - 'XPC_FLAGS': '0x0', 11:48:35 INFO - 'XPC_SERVICE_NAME': '0', 11:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:35 INFO - Downloading/unpacking psutil>=3.1.1 11:48:35 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 11:48:35 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 11:48:35 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 11:48:35 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 11:48:35 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 11:48:35 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 11:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:48:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:39 INFO - Installing collected packages: psutil 11:48:39 INFO - Running setup.py install for psutil 11:48:39 INFO - building 'psutil._psutil_osx' extension 11:48:39 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 11:48:39 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 11:48:39 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 11:48:40 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 11:48:40 INFO - building 'psutil._psutil_posix' extension 11:48:40 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 11:48:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:48:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:48:40 INFO - ^ 11:48:40 INFO - 1 warning generated. 11:48:40 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 11:48:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:40 INFO - Successfully installed psutil 11:48:40 INFO - Cleaning up... 11:48:40 INFO - Return code: 0 11:48:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:48:40 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')]} 11:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:40 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')]} 11:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:40 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 0x10cdc7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947b5e2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cba5d30>, '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 0x10caccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb9abe8>, '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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 11:48:40 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 11:48:40 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 11:48:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VFdd0Cljf3/Render', 11:48:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:40 INFO - 'HOME': '/Users/cltbld', 11:48:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:40 INFO - 'LOGNAME': 'cltbld', 11:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:40 INFO - 'MOZ_NO_REMOTE': '1', 11:48:40 INFO - 'NO_EM_RESTART': '1', 11:48:40 INFO - 'PAGER': '/bin/cat', 11:48:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:40 INFO - 'PWD': '/builds/slave/test', 11:48:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:40 INFO - 'SHELL': '/bin/bash', 11:48:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4ZdV1cgKX/Listeners', 11:48:40 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 11:48:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:40 INFO - 'USER': 'cltbld', 11:48:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:40 INFO - 'XPC_FLAGS': '0x0', 11:48:40 INFO - 'XPC_SERVICE_NAME': '0', 11:48:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:48:40 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 11:48:40 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 11:48:40 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 11:48:40 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 11:48:40 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 11:48:40 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 11:48:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:48:43 INFO - Installing collected packages: mozsystemmonitor 11:48:43 INFO - Running setup.py install for mozsystemmonitor 11:48:43 INFO - Successfully installed mozsystemmonitor 11:48:43 INFO - Cleaning up... 11:48:43 INFO - Return code: 0 11:48:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cdc7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947b5e2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cba5d30>, '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 0x10caccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb9abe8>, '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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 11:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:48:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VFdd0Cljf3/Render', 11:48:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:43 INFO - 'HOME': '/Users/cltbld', 11:48:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:43 INFO - 'LOGNAME': 'cltbld', 11:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:43 INFO - 'MOZ_NO_REMOTE': '1', 11:48:43 INFO - 'NO_EM_RESTART': '1', 11:48:43 INFO - 'PAGER': '/bin/cat', 11:48:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:43 INFO - 'PWD': '/builds/slave/test', 11:48:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:43 INFO - 'SHELL': '/bin/bash', 11:48:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4ZdV1cgKX/Listeners', 11:48:43 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 11:48:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:43 INFO - 'USER': 'cltbld', 11:48:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:43 INFO - 'XPC_FLAGS': '0x0', 11:48:43 INFO - 'XPC_SERVICE_NAME': '0', 11:48:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:43 INFO - Downloading/unpacking jsonschema==2.5.1 11:48:43 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 11:48:43 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 11:48:43 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 11:48:43 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 11:48:43 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 11:48:43 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 11:48:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:48:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:48:46 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 11:48:46 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 11:48:46 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 11:48:46 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 11:48:46 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 11:48:46 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 11:48:46 INFO - Downloading functools32-3.2.3-2.tar.gz 11:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:48:47 INFO - warning: no files found matching '*.txt' 11:48:47 INFO - no previously-included directories found matching 'build' 11:48:47 INFO - no previously-included directories found matching 'dist' 11:48:47 INFO - no previously-included directories found matching '.git*' 11:48:47 INFO - Installing collected packages: jsonschema, functools32 11:48:47 INFO - Running setup.py install for functools32 11:48:47 INFO - warning: no files found matching '*.txt' 11:48:47 INFO - no previously-included directories found matching 'build' 11:48:47 INFO - no previously-included directories found matching 'dist' 11:48:47 INFO - no previously-included directories found matching '.git*' 11:48:47 INFO - Successfully installed jsonschema functools32 11:48:47 INFO - Cleaning up... 11:48:47 INFO - Return code: 0 11:48:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:48:47 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')]} 11:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:47 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')]} 11:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:47 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 0x10cdc7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947b5e2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cba5d30>, '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 0x10caccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb9abe8>, '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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 11:48:47 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 11:48:47 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 11:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VFdd0Cljf3/Render', 11:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:47 INFO - 'HOME': '/Users/cltbld', 11:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:47 INFO - 'LOGNAME': 'cltbld', 11:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:47 INFO - 'MOZ_NO_REMOTE': '1', 11:48:47 INFO - 'NO_EM_RESTART': '1', 11:48:47 INFO - 'PAGER': '/bin/cat', 11:48:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:47 INFO - 'PWD': '/builds/slave/test', 11:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:47 INFO - 'SHELL': '/bin/bash', 11:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4ZdV1cgKX/Listeners', 11:48:47 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 11:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:47 INFO - 'USER': 'cltbld', 11:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:47 INFO - 'XPC_FLAGS': '0x0', 11:48:47 INFO - 'XPC_SERVICE_NAME': '0', 11:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:48:47 INFO - Cleaning up... 11:48:47 INFO - Return code: 0 11:48:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:48:47 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')]} 11:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:47 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')]} 11:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:47 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 0x10cdc7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947b5e2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cba5d30>, '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 0x10caccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb9abe8>, '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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 11:48:47 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 11:48:47 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 11:48:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VFdd0Cljf3/Render', 11:48:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:47 INFO - 'HOME': '/Users/cltbld', 11:48:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:47 INFO - 'LOGNAME': 'cltbld', 11:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:47 INFO - 'MOZ_NO_REMOTE': '1', 11:48:47 INFO - 'NO_EM_RESTART': '1', 11:48:47 INFO - 'PAGER': '/bin/cat', 11:48:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:47 INFO - 'PWD': '/builds/slave/test', 11:48:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:47 INFO - 'SHELL': '/bin/bash', 11:48:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4ZdV1cgKX/Listeners', 11:48:47 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 11:48:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:47 INFO - 'USER': 'cltbld', 11:48:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:47 INFO - 'XPC_FLAGS': '0x0', 11:48:47 INFO - 'XPC_SERVICE_NAME': '0', 11:48:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:47 INFO - Downloading/unpacking blobuploader==1.2.4 11:48:47 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 11:48:47 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 11:48:47 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 11:48:47 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 11:48:47 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 11:48:47 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 11:48:50 INFO - Downloading blobuploader-1.2.4.tar.gz 11:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:48:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:48:50 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 11:48:50 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 11:48:50 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 11:48:50 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 11:48:50 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 11:48:50 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 11:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:48:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:48:51 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 11:48:51 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 11:48:51 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 11:48:51 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 11:48:51 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 11:48:51 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 11:48:51 INFO - Downloading docopt-0.6.1.tar.gz 11:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:48:51 INFO - Installing collected packages: blobuploader, requests, docopt 11:48:51 INFO - Running setup.py install for blobuploader 11:48:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:48:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:48:52 INFO - Running setup.py install for requests 11:48:52 INFO - Running setup.py install for docopt 11:48:52 INFO - Successfully installed blobuploader requests docopt 11:48:52 INFO - Cleaning up... 11:48:52 INFO - Return code: 0 11:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:52 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 0x10cdc7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947b5e2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cba5d30>, '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 0x10caccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb9abe8>, '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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 11:48:52 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 11:48:52 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 11:48:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VFdd0Cljf3/Render', 11:48:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:52 INFO - 'HOME': '/Users/cltbld', 11:48:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:52 INFO - 'LOGNAME': 'cltbld', 11:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:52 INFO - 'MOZ_NO_REMOTE': '1', 11:48:52 INFO - 'NO_EM_RESTART': '1', 11:48:52 INFO - 'PAGER': '/bin/cat', 11:48:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:52 INFO - 'PWD': '/builds/slave/test', 11:48:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:52 INFO - 'SHELL': '/bin/bash', 11:48:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4ZdV1cgKX/Listeners', 11:48:52 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 11:48:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:52 INFO - 'USER': 'cltbld', 11:48:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:52 INFO - 'XPC_FLAGS': '0x0', 11:48:52 INFO - 'XPC_SERVICE_NAME': '0', 11:48:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-dXi4cW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-iO8BET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-cSAto0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-wg36kU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-2c86qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-NOyTqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-4GLsd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-noBAw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-QzTtla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Nc8Vcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Q6rGI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-2JTykT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-eVt_TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-pDFTAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-68wupk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-KsLSJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:54 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-2A3x__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:48:54 INFO - Running setup.py install for manifestparser 11:48:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:48:54 INFO - Running setup.py install for mozcrash 11:48:55 INFO - Running setup.py install for mozdebug 11:48:55 INFO - Running setup.py install for mozdevice 11:48:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:48:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:48:55 INFO - Running setup.py install for mozfile 11:48:55 INFO - Running setup.py install for mozhttpd 11:48:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:48:55 INFO - Running setup.py install for mozinfo 11:48:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:48:55 INFO - Running setup.py install for mozInstall 11:48:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:48:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:48:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:48:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:48:56 INFO - Running setup.py install for mozleak 11:48:56 INFO - Running setup.py install for mozlog 11:48:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:48:56 INFO - Running setup.py install for moznetwork 11:48:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:48:56 INFO - Running setup.py install for mozprocess 11:48:56 INFO - Running setup.py install for mozprofile 11:48:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:48:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:48:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:48:56 INFO - Running setup.py install for mozrunner 11:48:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:48:56 INFO - Running setup.py install for mozscreenshot 11:48:57 INFO - Running setup.py install for moztest 11:48:57 INFO - Running setup.py install for mozversion 11:48:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:48:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:48:57 INFO - Cleaning up... 11:48:57 INFO - Return code: 0 11:48:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48: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')]} 11:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48: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')]} 11:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:58 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 0x10cdc7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947b5e2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cba5d30>, '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 0x10caccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb9abe8>, '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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 11:48:58 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 11:48:58 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 11:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VFdd0Cljf3/Render', 11:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:48:58 INFO - 'HOME': '/Users/cltbld', 11:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:48:58 INFO - 'LOGNAME': 'cltbld', 11:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:58 INFO - 'MOZ_NO_REMOTE': '1', 11:48:58 INFO - 'NO_EM_RESTART': '1', 11:48:58 INFO - 'PAGER': '/bin/cat', 11:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:58 INFO - 'PWD': '/builds/slave/test', 11:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:48:58 INFO - 'SHELL': '/bin/bash', 11:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4ZdV1cgKX/Listeners', 11:48:58 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 11:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:48:58 INFO - 'USER': 'cltbld', 11:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:58 INFO - 'XPC_FLAGS': '0x0', 11:48:58 INFO - 'XPC_SERVICE_NAME': '0', 11:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-1o_CrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-V6uAqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 11:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-cwmgyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:58 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)) 11:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-1TV0Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 11:48:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:58 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-467M6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:59 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)) 11:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Z8l6b0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:59 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)) 11:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-0IuEja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:59 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)) 11:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-fp5jI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:59 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)) 11:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-nEirDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:59 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)) 11:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-8Gdqdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:59 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)) 11:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-czdVaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:59 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)) 11:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-lK_o2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 11:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-QyVa6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:59 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)) 11:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:59 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-lm5pTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 11:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:00 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-KluzPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:00 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)) 11:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:00 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-i3EDBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 11:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:00 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-DYsylR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:00 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)) 11:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:49:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:49:00 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)) 11:49:00 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:49:00 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:49:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49:03 INFO - Downloading blessings-1.6.tar.gz 11:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:49:03 INFO - Installing collected packages: blessings 11:49:03 INFO - Running setup.py install for blessings 11:49:03 INFO - Successfully installed blessings 11:49:03 INFO - Cleaning up... 11:49:03 INFO - Return code: 0 11:49:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:49:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:04 INFO - Reading from file tmpfile_stdout 11:49:04 INFO - Current package versions: 11:49:04 INFO - blessings == 1.6 11:49:04 INFO - blobuploader == 1.2.4 11:49:04 INFO - docopt == 0.6.1 11:49:04 INFO - functools32 == 3.2.3-2 11:49:04 INFO - jsonschema == 2.5.1 11:49:04 INFO - manifestparser == 1.1 11:49:04 INFO - mozInstall == 1.12 11:49:04 INFO - mozcrash == 1.0 11:49:04 INFO - mozdebug == 0.1 11:49:04 INFO - mozdevice == 0.49 11:49:04 INFO - mozfile == 1.2 11:49:04 INFO - mozhttpd == 0.7 11:49:04 INFO - mozinfo == 0.9 11:49:04 INFO - mozleak == 0.1 11:49:04 INFO - mozlog == 3.4 11:49:04 INFO - moznetwork == 0.27 11:49:04 INFO - mozprocess == 0.24 11:49:04 INFO - mozprofile == 0.28 11:49:04 INFO - mozrunner == 6.13 11:49:04 INFO - mozscreenshot == 0.1 11:49:04 INFO - mozsystemmonitor == 0.3 11:49:04 INFO - moztest == 0.8 11:49:04 INFO - mozversion == 1.4 11:49:04 INFO - psutil == 3.1.1 11:49:04 INFO - requests == 1.2.3 11:49:04 INFO - wsgiref == 0.1.2 11:49:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:04 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')]} 11:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:04 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')]} 11:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:04 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 0x10cdc7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947b5e2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cba5d30>, '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 0x10caccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb9abe8>, '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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 11:49:04 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 11:49:04 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 11:49:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VFdd0Cljf3/Render', 11:49:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:04 INFO - 'HOME': '/Users/cltbld', 11:49:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:04 INFO - 'LOGNAME': 'cltbld', 11:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:04 INFO - 'MOZ_NO_REMOTE': '1', 11:49:04 INFO - 'NO_EM_RESTART': '1', 11:49:04 INFO - 'PAGER': '/bin/cat', 11:49:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:04 INFO - 'PWD': '/builds/slave/test', 11:49:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:04 INFO - 'SHELL': '/bin/bash', 11:49:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4ZdV1cgKX/Listeners', 11:49:04 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 11:49:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:04 INFO - 'USER': 'cltbld', 11:49:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:04 INFO - 'XPC_FLAGS': '0x0', 11:49:04 INFO - 'XPC_SERVICE_NAME': '0', 11:49:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:04 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)) 11:49:04 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)) 11:49:04 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)) 11:49:04 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)) 11:49:04 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)) 11:49:04 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)) 11:49:04 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)) 11:49:04 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)) 11:49:04 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)) 11:49:04 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)) 11:49:04 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)) 11:49:04 INFO - Cleaning up... 11:49:04 INFO - Return code: 0 11:49:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:49:04 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')]} 11:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:04 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')]} 11:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:04 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 0x10cdc7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdca768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947b5e2cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cba5d30>, '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 0x10caccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb9abe8>, '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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 11:49:04 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 11:49:04 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 11:49:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VFdd0Cljf3/Render', 11:49:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:04 INFO - 'HOME': '/Users/cltbld', 11:49:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:04 INFO - 'LOGNAME': 'cltbld', 11:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:04 INFO - 'MOZ_NO_REMOTE': '1', 11:49:04 INFO - 'NO_EM_RESTART': '1', 11:49:04 INFO - 'PAGER': '/bin/cat', 11:49:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:04 INFO - 'PWD': '/builds/slave/test', 11:49:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:04 INFO - 'SHELL': '/bin/bash', 11:49:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4ZdV1cgKX/Listeners', 11:49:04 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 11:49:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:04 INFO - 'USER': 'cltbld', 11:49:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:04 INFO - 'XPC_FLAGS': '0x0', 11:49:04 INFO - 'XPC_SERVICE_NAME': '0', 11:49:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:49:04 INFO - Cleaning up... 11:49:04 INFO - Return code: 0 11:49:04 INFO - Running post-action listener: _resource_record_post_action 11:49:04 INFO - Running post-action listener: _start_resource_monitoring 11:49:04 INFO - Starting resource monitoring. 11:49:04 INFO - [mozharness: 2017-02-17 19:49:04.582479Z] Finished create-virtualenv step (success) 11:49:04 INFO - [mozharness: 2017-02-17 19:49:04.583519Z] Running install step. 11:49:04 INFO - Running pre-action listener: _resource_record_pre_action 11:49:04 INFO - Running main action method: install 11:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:04 INFO - Reading from file tmpfile_stdout 11:49:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:49:04 INFO - Reading from file tmpfile_stdout 11:49:04 INFO - Output received: 11:49:04 INFO - Usage: mozinstall [options] installer 11:49:04 INFO - Options: 11:49:04 INFO - -h, --help show this help message and exit 11:49:04 INFO - -d DEST, --destination=DEST 11:49:04 INFO - Directory to install application into. [default: 11:49:04 INFO - "/builds/slave/test"] 11:49:04 INFO - --app=APP Application being installed. [default: firefox] 11:49:04 INFO - mkdir: /builds/slave/test/build/application 11:49:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:49:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 11:49:24 INFO - Reading from file tmpfile_stdout 11:49:24 INFO - Output received: 11:49:24 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 11:49:24 INFO - Running post-action listener: _resource_record_post_action 11:49:24 INFO - [mozharness: 2017-02-17 19:49:24.907573Z] Finished install step (success) 11:49:24 INFO - [mozharness: 2017-02-17 19:49:24.907710Z] Running run-tests step. 11:49:24 INFO - Running pre-action listener: _resource_record_pre_action 11:49:24 INFO - Running main action method: run_tests 11:49:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:49:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:49:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:49:24 INFO - 2017-02-17 11:49:24.921 screenresolution[1623:7288] starting screenresolution argv=screenresolution get 11:49:24 INFO - 2017-02-17 11:49:24.924 screenresolution[1623:7288] Display 0: 1600x1200x32@60 11:49:24 INFO - 2017-02-17 11:49:24.930 screenresolution[1624:7291] starting screenresolution argv=screenresolution list 11:49:24 INFO - Available Modes on Display 0 11:49:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:49:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:49:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:49:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:49:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:49:25 INFO - Intel Iris: 11:49:25 INFO - Chipset Model: Intel Iris 11:49:25 INFO - Type: GPU 11:49:25 INFO - Bus: Built-In 11:49:25 INFO - VRAM (Dynamic, Max): 1536 MB 11:49:25 INFO - Vendor: Intel (0x8086) 11:49:25 INFO - Device ID: 0x0a2e 11:49:25 INFO - Revision ID: 0x0009 11:49:25 INFO - Displays: 11:49:25 INFO - Display: 11:49:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:49:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:49:25 INFO - Display Serial Number: 1600x1200 60 11:49:25 INFO - Main Display: Yes 11:49:25 INFO - Mirror: Off 11:49:25 INFO - Online: Yes 11:49:25 INFO - Rotation: Supported 11:49:25 INFO - Return code: 0 11:49:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:49:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:49:25 INFO - Python 2.7.3 11:49:25 INFO - Return code: 0 11:49:25 INFO - grabbing minidump binary from tooltool 11:49:25 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')]} 11:49:25 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 0x10cba5d30>, '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 0x10caccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb9abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:49:25 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 11:49:25 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 11:49:25 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 11:49:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:49:25 INFO - Return code: 0 11:49:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:49:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:49:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:49:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:49:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:49:25 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/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 11:49:25 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/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --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 11:49:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VFdd0Cljf3/Render', 11:49:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:25 INFO - 'HOME': '/Users/cltbld', 11:49:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:25 INFO - 'LOGNAME': 'cltbld', 11:49:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:49:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:49:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:25 INFO - 'MOZ_NO_REMOTE': '1', 11:49:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:49:25 INFO - 'NO_EM_RESTART': '1', 11:49:25 INFO - 'PAGER': '/bin/cat', 11:49:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:25 INFO - 'PWD': '/builds/slave/test', 11:49:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:49:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:25 INFO - 'SHELL': '/bin/bash', 11:49:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.R4ZdV1cgKX/Listeners', 11:49:25 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 11:49:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:25 INFO - 'USER': 'cltbld', 11:49:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:25 INFO - 'XPC_FLAGS': '0x0', 11:49:25 INFO - 'XPC_SERVICE_NAME': '0', 11:49:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:25 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/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--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 11:49:25 INFO - mozversion application_buildid: 20170217110819 11:49:25 INFO - mozversion application_changeset: db2e6ff03ae1c57ebd4b4dae874d744bd1b8a41b 11:49:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:49:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:49:25 INFO - mozversion application_name: Firefox 11:49:25 INFO - mozversion application_remotingname: firefox-dev 11:49:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:49:25 INFO - mozversion application_vendor: Mozilla 11:49:25 INFO - mozversion application_version: 53.0a2 11:49:25 INFO - mozversion platform_buildid: 20170217110819 11:49:25 INFO - mozversion platform_changeset: db2e6ff03ae1c57ebd4b4dae874d744bd1b8a41b 11:49:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:49:25 INFO - mozversion platform_version: 53.0a2 11:49:25 INFO - using testdate: 1487360965 11:49:25 INFO - actual date: 1487360965 11:49:25 INFO - starting webserver on 'localhost:49244' 11:49:25 INFO - SUITE-START | Running 2 tests 11:49:25 INFO - TEST-START | dromaeo_css 11:49:25 INFO - operating with platform_type : mac_ 11:49:25 INFO - Initialising browser for dromaeo_css test... 11:49:25 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp4uo7kR/profile http://localhost:49244/getInfo.html) 11:49:28 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 11:49:28 INFO - PROCESS | 1634 | colorDepth:24 11:49:28 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 11:49:28 INFO - PROCESS | 1634 | __metrics 11:49:28 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:49:28 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:49:28 INFO - TEST-INFO | 1634: exit 0 11:49:28 INFO - Browser initialized. 11:49:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:49:28 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp4uo7kR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:49:41 INFO - PROCESS | 1636 | RSS: Main: 213295104 11:49:41 INFO - PROCESS | 1636 | 11:52:45 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 11:52:47 INFO - PROCESS | 1636 | RSS: Main: 385818624 11:52:47 INFO - PROCESS | 1636 | 11:54:31 INFO - PROCESS | 1636 | ************************* 11:54:31 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 11:54:31 INFO - PROCESS | 1636 | 11:54:31 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:54:31 INFO - PROCESS | 1636 | Full stack: 11:54:31 INFO - PROCESS | 1636 | ************************* 11:55:51 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 11:55:51 INFO - PROCESS | 1636 | RSS: Main: 356954112 11:55:51 INFO - PROCESS | 1636 | 11:58:54 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 11:58:54 INFO - PROCESS | 1636 | RSS: Main: 341749760 11:58:54 INFO - PROCESS | 1636 | 12:01:57 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 12:01:57 INFO - PROCESS | 1636 | RSS: Main: 333963264 12:01:57 INFO - PROCESS | 1636 | 12:05:01 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 12:05:01 INFO - PROCESS | 1636 | RSS: Main: 315183104 12:05:01 INFO - PROCESS | 1636 | 12:08:05 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 12:08:05 INFO - PROCESS | 1636 | RSS: Main: 396668928 12:08:05 INFO - PROCESS | 1636 | 12:08:05 INFO - PROCESS | 1636 | __start_tp_report 12:08:05 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 12:08:05 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 12:08:05 INFO - PROCESS | 1636 | |i|pagename|runs| 12:08:05 INFO - PROCESS | 1636 | |0;dojo.html;3114.408262430138;3374.730021598274;3380.8985730428067;3387.2886693794303;3433.193199598094;5679.971600142004;5695.658260504372;5722.628029178106;5746.195532625436;5763.164341170528;5484.7531861066245;5645.125005624124;5714.085746280596;5717.085266357383;5754.02181629123;5198.116320225571;5250.291210686566;5252.973735131338;5276.261323414725;5311.654742441749;5186.948130518703;5187.455317191679;5198.298229738974;5328.413874473805;5341.706206158659;5246.8688282792855;5260.8158714445;5274.789008439658;5288.814891478799;5296.3379577552805;5294.444083371229;5308.097623404011;5310.123829568117;5314.654547454442;5328.946710532903;5181.585473162176;5262.289590905255;5263.842084737464;5271.0248604008;5277.947220527784;5561.916571251434;5597.692126933058;5609.691466969315;5723.370429252779;5730.512906402961;5192.299039629677;6197.380261973812;6229.781957631507;6305.464035556983;6320.304766475684;6226.128342032119;6275.2783429905685;6287.591306565105;6309.400606942333;6313.873722525524;5665.943340566624;5805.3323867755325;5808.186853840466;5845.824625261249;5908;6234.501239900797;6275.278342990615;6287.434130928238;6318.6524741138755;6326.2092238470195;6209.65846878417;6212.254529456494;6215.844603884939;6217.378262173746;6223.0354295084335;6246;6253.030780229072;6286.654234017082;6298.7795427160745;6300.716467758962;6083.6045657032155;6124.360903754287;6128.7893521635915;6134.8346010261785;6266;6214.844628884314;6249.78125765596;6263;6263.812085637438;6266.874662506724;4993.825216117419;5000.1249781288125;5004.399472063303;5024.824131155465;5042.2184561392305;3649.6897763689853;4219.135077309205;4297.742135471882;4455.554444555519;4495.19086564415;5601.495865372054;5727.4845263926445;5739.225204597409;5748.166515855261;5748.568857335633;6223.657698826608;6231.1276421300145;6234.0025595905345;6236.18929539157;6236.220472440945;5781.306243250837;5862.296524417097;5872.677002764804;5874.94125058744;5883.794067207627;5448.37343705471;5511.366192887789;5515.779368825282;5525.668459892419;5530.281063461724;6172.321044684992;6218.626882387071;6392.520560957947;6397.200349956255;6398.776042838478;6246.5002799775;6249.500039996698;6250.0937364082865;6251.9062214067735;6255.155554000152;6232;6240.344763799736;6273.153124328157;6352.047192921099;6359.300476947439;6217.658028808459;6221.720022598904;6222.253329600477;6228.719707613259;6243.500519958483;6130.0312685453755;6208.317085120543;6210.254769427517;6230.034344676583;6235.438810507076;6026.668533230539;6084.056971169476;6117.449429551361;6117.522930757332;6132.233136608164;6147.139400484025;6177.413145751147;6190.752369905334;6191.411815877665;6195.659238741732;6022.608530445507;6034.818955431344;6041.69791510414;6054.666993315233;6088.26940767093;5968.641881487125;6015.789447369321;6105.084237364431;6118.649636126507;6141.723622436912;5775.104858746901;5800.9848276552275;5816.563757718103;6018.36807135262;6052.66710330936 12:08:05 INFO - PROCESS | 1636 | |1;ext.html;442.7609091090811;482.7857937287721;503.18986431844723;504.8741306885647;568.0570253379391;35838;41958.790206049;41986.74039778804;42152.57847421521;44041.779791101;43309.35035974455;43568;43645.345319820226;43691;43699.56300436995;8440.74677759665;9266.397684150526;9452.007539208387;9469.526523673823;9489.66786162481;8461.746147615582;11212.719682007973;11403.600873969413;11497.310161390302;11627.593034243802;11356.602518911839;11449.542018319256;11450.770984580304;11459.312441253509;11460.025897798698;11405.258658187233;11472.483738231758;11482.712932176679;11497.712557186054;11561.479733412016;8431.578421078983;8634.784130396727;9430.952845235799;11081.390523521284;11298.265612735146;41687.583124168676;41988.790056049525;42029.57970420287;42078.78960605208;42209.944751381154;3856.4606194888925;3970.5235371755575;4012.578679238696;4025.5571887092397;4031.072853243741;27428;27434.5884811728;27456;27680.446391072266;28238.011669591466;2883.4521440926155;3061.586685797411;3141.104785136225;3164.4145833020734;3164.984175079133;463629;466118;466531;469858;471274;56325.15512267319;56703.58241044007;56720;56725.58186045382;56829;58984.70507647434;59029.819403611684;59153.8592298535;59168.816623667284;59211.70394148002;15602.29789659468;15876.761848572281;16124.838751612333;16173.029618222945;16183.867129301072;11186.440677966231;11480.081593472501;12510.562130325396;12644.051696122828;12654.493820247088;16106.597335066717;18549.74704890399;22063.66904496434;22273.44316392103;22506.76212808311;8647.567621618893;8734.388592798443;8752.91247087521;8861.424007439497;8923.643054277756;850.4259624753266;866.1035827918074;866.3372520022189;877.8018005422553;895.1764376773255;25261.87369063143;26174.6073808893;30761;31484.842575786974;31509.897153599515;994.3487016004528;1071.7052810477026;1071.737424331044;1121.4224674292745;1131.6378758797107;15397.615059623598;15937.68124637524;15940.043597384194;16044.839551604568;16393.34426622922;657122;660716;662392;662540;664317;63387.683061584394;63671.36328636747;63852;63926.680366597866;64021;1423.352374669523;1429.842717301096;1459.37246983798;1469.5811693667254;1471.6247356923916;25029.624555631315;27757.722422775514;29389.77586353175;29582.408351833274;29616.407671846013;52505.42483725494;53023.99999999846;53167.936641266184;53192.93614127773;53225.7338713304;603987;609944;610915;611129;611768;33350.66649333476;33620.82327118539;40339.79830100948;40849;41072;41890;43432.34851477294;43885.56114438815;43921.34117988297;44182;29127.271818204714;32855.83572082124;35027.47458788171;35770;36278;35415.29169416649;35546.46680299849;36308.455373168894;36493;36641.267174655826;24761.876190618932;34496;34972.65027349694;35333.29333413369;35941.921742347775;25944.351391214615;29760.10719678413;31185.53221701631;32080.358392831546;32266;22261.666075009212;23891.522169556858;24302.51394972126;24334.51330973406;24455.877720611283 12:08:05 INFO - PROCESS | 1636 | |2;jquery.html;337.7871940677373;359.8236863936672;379.5123266602416;392.89195471245415;418.36617524450446;14788.6302842429;15002.324895379707;16753.246103925336;20194.29319973801;21025.894870525626;19967.600647987067;20537.794622053774;20625.174993000262;20849.853258070838;21228.363149105513;5184.300119483859;5188.37739471264;5415.702136382497;5420.756065977021;5425.457454254582;5292.232626269189;5434.809781657643;5445.074337362638;5445.9727701361435;5451.536619387357;3879.1853710720784;4102.630763231308;6022.187004754368;6679.198496180441;6711.899321510181;6431.421172094534;6653.7671181508895;6755.459563234929;6768.729250829961;6782.864342713118;5924.200232968537;5946.108083787423;5952.434518720715;5955.761769529214;5958.731857066442;13147.211167329991;13207.207567545978;13407.329633518286;13458.259795711232;20670.379888603366;2483.4784695214025;2584.095566551711;2950.173951293641;2956.4826155422716;2958.881644734208;7164.498485106044;7168;7578.658960346797;9847.753806154831;10309.53607087683;1774.6007148391639;1783.1262681286075;1783.6076063266062;1799.5591080185438;1799.9100044997829;123300.38349808194;123606;125165;129835;130378.3481082598;11134.659602119333;11682.88317116818;11685.591004314809;11714.067178915384;11872.88127118735;14910.254487275593;14931.70136597262;15318.080915145127;15320.770188447183;15394.307256173499;8410.621522031523;8645.524496152646;8681.56592170389;8753.868691969625;8762;7638;7664.923350766421;8306.418550701394;8416.368772341977;8506.914930850737;4522.806438877142;4570.428696412949;4665.4168228971375;4751.501092385319;4760.404949381327;1923.6633589122127;1972.4871533401133;1979.2973494409566;1988.77129130149;1990.8905010224578;965.4352203960622;965.8599503072015;1001.5442973447064;1002.588938535197;1018.9796204075877;20710;20932.686009709865;21016.579668406546;21070;21495.57008859814;981.3326937682302;989.4854675568664;1013;1016.1413605503485;1025.564135242519;9429.198518125899;11057.834132488018;11205.271657342246;11208.66374008781;11219.943900280447;731182;736040;737331;752382;756904.21547893;144796;150238;150921;152671.47328526794;157683;970.6893793985998;1017.5421060522647;1050.5062620568322;1050.5745173204864;1055.9683209503728;19370.35351995096;19983.700244496053;20134.194632215134;20584.27955021567;20687.482812929196;59880.80238395295;60358;61357.38642613517;61564.69217653883;62983;86776.26447471141;87650.56174719086;88175.55912220398;88530.55734721285;88546;8417.494950302756;8448.873266901124;8455.704050358208;8518.211175653183;8532.402731808714;9320.067993200626;10968.122550195805;12789.61631151067;13093.148945318524;13658.317084145554;9581.473018984023;10290.485475726035;10625.734356641145;11103.5558577656;11474;11235.831462527905;11362.829557556477;11522.53909843597;11539.711507212387;11779;9508.952455237679;11136.053435458076;11594.826077608674;11666.650000499998;11809.937105660532;8315.916840831756;8471.534065626449;8561.44350617208;8680.392372533863;8776.16626420489;10159.390436573829;11180.608678696206;11237.3257604544;11280.830787538029;11618.244814087057 12:08:05 INFO - PROCESS | 1636 | |3;mootools.html;1432.4055516960461;1436.432609119398;1453.1499073042269;1454.3528129982162;1460.5034288341965;6135.32511423743;8423.957880210606;8424.452410593314;8432.156784321565;8448.91551084489;7320.341169294762;7615.086189657235;7619.085709714842;7816.96091519543;7913.841723165548;2070.7929207079283;2335.976640233593;2338.9532209355802;2342.8711420871846;2346.2609278077352;2327.8137748980125;2354.693889794324;2366.6331718583647;2374.2165085521824;2378.0368950575044;2307.2040146149634;2317.212147869724;2333.6616190652344;2340.3564019894493;2347.377944844609;2261.547690461906;2274.965875511852;2292.106078629336;2294.598445272071;2303.9308820735405;2254.1096266974455;2284.23478134825;2316.073570571768;2316.953660926772;2321.8839058047197;6948.652567371611;8313.33493320533;8332.33341332698;8332.458390204678;8352.206540378655;5022.974885125587;5192.636515443921;5198.038362902875;5202.68783872965;5202.843914682566;3181.618205815317;3266.3304022675293;3441.638627944055;3450.9482357764655;3454.827258637083;1155.2375432214699;1178.4932479034012;1180.3626041937343;1182.8876256755595;1213.7511810079002;10668.839967400496;10768;10784.5686172553;10786.406747628876;10797.892021079768;4407.603315701603;4624.5375462453485;4689.343491911135;4723.881902952385;4733;9396.342256042011;9400.24798016157;9423.869135703759;9427.387219830689;9433.009533998831;5103.897922041612;5193.428722840485;5212.166053431509;5220.060389129993;5223.9477605223465;3933.1740334529495;4245.61789438952;4370.322599997005;4658.58072773452;4781.617470602343;3839.9232015360094;3845.8269377878064;3941.2905676977844;3952.5652178260943;4015.3374693175297;1278.341654048166;1280.801475771257;1283.6277479531018;1290.4193113098954;1295.054610134607;778.1479280188184;844;903.9141281578239;914.9634014639473;921.1111277616998;5328.653637513549;5405.270288511001;5603.607747457639;5713.628614140068;5715.971420142872;999.68010236725;1004.2618675273668;1022.1873610479687;1032.70051685012;1051.6529545250048;3020.9546856797165;3569;3640.4346131163325;3677.191017976041;3855.4602355670227;9661.32370734056;10007;10009.899901001043;10022.448765317977;10034.498275086216;9820.950895245478;9858.112769850604;9934.354266972623;9947.502624868728;9961.252906032076;6890.827729306707;7576.28025337592;7766.37868970481;7807.765767026998;7912.762617121495;5631.465010824129;5632.915506267491;5722.17028530869;5728.742206600629;5799.304083509837;8592.226699597066;8596.968363796384;8845.4250473719;9060.275177985613;9352.064793520865;9126.634934602542;9234.445933244027;9392.81214375695;9467.621295148117;9553.904460955302;6472.8705425890275;6549.7707580236365;6713.160854893138;6957.1651401832105;7103.147622285359;6675.666216689243;7871.134175240604;7876.251756083163;8013;8022.197780221931;6949.68726407323;7117.82205444868;7137.286271373029;7225;7249.456290778318;6957.130358705162;6997.545159564612;7057.50597458173;7088.503804733619;7114.0396046535125;6350.618962862243;6373.107764913008;6438.3883531064475;6451.096846441408;6461.935380646321;4870.610351171827;4910.3125562422;4946.0355230729665;4948.455669876383;4974.925376119433;3984.5816189300867;4930.975345123252;5025.321581586439;5090.541851233407;5107.387113546398 12:08:05 INFO - PROCESS | 1636 | |4;prototype.html;320.6424836307517;347.7756846833792;352.12848200703263;368.1403921842501;371.3260432315346;4363.672724545656;5195.896082078366;5283.128283833168;5301.674581354661;5324.429293358459;4677.83627573035;4694.38972933519;4958.900821983558;5126.154184559553;5157.355330583677;3292.3579901919134;4094.529129150141;4124.566920473352;4174.833006679729;4201.466464740378;3399.490076488522;4154.646855017327;4182.142660754554;4192.24539582875;4211.768352740598;3775.7356985010924;4026.7047782763834;4078.5309689385804;4135.146748743373;4170.47869016373;4044.6157615026527;4063.167050754588;4113.8971525712095;4123.938140927903;4178.56125106864;3351.731861451078;3400;3457.930841383158;3487.843047062888;3565.5608767084886;4958.87602809929;5115.948840511584;5150.201718733602;5157.871053223662;5189.195674670432;3835.9232815343817;4279.679024073176;4564.1556312082375;4599.264117741145;4649.511801260853;4927.359443272351;5414.512693857532;5518.503334699856;5592.5246354059955;5609.083276696095;3351.262722201112;3659.0669379308106;3851.691864650821;3853.1715681128694;3869.961300386988;5507.200031977923;5796.855078623026;5844.94790937631;5859.4433528815125;5864.589478736448;3343.598768147789;3815.931539169037;3826.392914975717;3873.5545412277384;3880.708946828999;3934.8229329680235;3943.191645712622;3945.5265368155433;3955.228730397545;3981.92036159281;4045.6358927696647;4174.519930208005;4327.870163895088;4518.570735780096;4604.217283061887;5620.381758006616;5630.887382252414;5650;5654.858628534237;5709.571782116358;1120.5181771838024;1160.8897154770284;1259.557806311768;1270.9872901271053;1279.251637791902;717.8994940708305;726.4769366056431;775.2131586439768;841.4026041510596;850.2857599616352;4691.9530804692195;4775.450823155382;4802.135615589157;4820.903581928342;4856.708597484162;5366.163193316797;5390.919136212881;5448.700321482356;5449.792833902276;5455.453954929328;4483.273939533303;4795.640326975421;4836.298736683161;5143.305653736697;5219.625070592871;2567.7432256774173;2843.3460304130167;2869.741723244918;2875.9856200718864;2882.827030378184;5012.3233363495465;5176.456472070378;5474.275603184984;5477.507024367746;5495.928293982635;4736.573708366263;5588.658721906713;5594.496495315359;5617.297837770278;5648.260593612094;4873.927735898097;5608.803691870765;5691.715414229355;5707.6575405475805;5726.627769194989;4871.260252955414;4915.508449155056;5060.620453465931;5187.4984385538855;5454.290942177491;4427.889302767457;5333.7066461345;5360.276362690986;5432.56539476833;5463.535599474089;5054.194921818426;5120.899006713575;5317.548008419328;5496.945030549803;5730.326976293356;3515.064920791168;3517.43721004638;3601.4057680483475;3654.587971938508;3668.3396988541253;4659.510751371057;4698.84878204842;4731.574158325767;5285.942811437651;5413.5127838493145;4623.42207224097;4728.668993170445;5012.8496145115705;5294.49702278283;5304.443033481429;4240.943142575787;5014.796448852322;5057.671251368649;5092.287079808903;5162.457941916195;4542.704724192917;5235.1623740201385;5474.713442341126;5476.644018138808;5525.4474552546035;4525.773711314355;5137.768800403916;5447.428020057837;5453.036906713659;5461.399246083007;4348.826046958086;5284.0184930651;5286.841394758163;5447.264619276347;5466.371367292653 12:08:05 INFO - PROCESS | 1636 | |5;yui.html;622.7607061946727;645.154847150233;722;813.3371302388554;824.9628766705499;14841.628959276024;15767;15791.842081579196;15793.210339483023;15808.209589520508;14085.92957035216;14367.856321436782;14493.637659058502;14506.274686265671;14513.854861451382;679.9932000679979;842.4608250719529;856.618804631939;858.6007506509471;861.7113267055544;695.1935754524752;704.3625518905374;831.4678605692362;849.0999540487103;870.7953630896734;912.2884150362728;914.4239129348534;914.501596629835;916.2212119698237;917.1287277086761;910.6767097680328;912.1243606138115;912.1380295620642;912.3066469483207;913.4108500017452;529.1427886823333;544.861060429588;644.8097811145723;661.8279247395664;662.3409707341178;15343.07941523512;15358.385664573403;15370.308336124901;15382.230888455533;15395.461158859498;13726.725465490634;13738.587842364745;13800.861991380058;13836.169829810244;13878.653033674138;11980.400979950968;12083.45624446902;12154.149209555335;12585.24488530691;12634;4267.765272909989;4382.028087360701;4450.799714012877;4569.1547063793305;4605.700629459075;94130.52934735351;98800;101893;102226;102295;10546.841797373045;10692.305000174963;10835.241533092609;11308.49111789955;11548.94225528867;22136.225232116798;22370.552588948456;22776.886115569316;22854;22862;7603.239676032353;7649.464537482434;7741.2645798650165;7754.457187996899;7911.564863932539;4009.0730078018246;4026.4362989181536;4034.9148527465254;4107.445494858216;4136.9793151034055;3486.930261394758;3567;3575.4994300797907;3592.6946209571956;3607.2785442911522;626.9592476489014;631.4948041566728;632.3076231526563;643.0868167202584;645.7965740791635;610.5725991805754;622.3993845938691;637.6014990630856;638.7572722365471;645.2676212498753;7931.643076061591;8263.669453221924;9131.174790233783;9627.951860240653;9672.08115229052;619.8202521268872;620.534599050712;633.6071635585967;637.2416823979449;668.5320275806955;3857.7106716996336;4291.661044730629;4672.6261899047995;4683.437987441461;4690.132325519789;93890;96705.0329496696;99684.50157749165;104842;105858.47070764597;57453.27640170802;73438.63280683562;89901.10098898927;91367.81063214941;94040;78089;78319;79783.60108199422;81056.18943810604;81238.59380703176;8687.64572226246;9150.542472876197;9187;9199.26405887514;9256.398334108262;42867.785661071495;46254.537454625024;50211.24683129683;50544;51301;68425;68795.31204687888;69231;70788.64605676939;71193.28806711867;7732;10971.396573188551;11031.669049928514;11457.885421145682;12036.277823330629;12070.053409514347;12189;12233.388330583613;12280.570180043656;12610.873891261337;11777.040013978409;11973.281603103842;11991.520339186334;12836.807447888103;13718.862811372157;13120.015998799938;13144.60566183016;13362.964873727007;13694.931525342708;14111.22388268655;12575.748485030064;12897.290649014394;13099.607011789662;13169.02428185539;13517.324133793467;10952.726181845517;10995.725106872393;11195.2723073;11542;11681.766364672489;8032.63853126599;10775.461226938778;10872;11327.490262938023;11582.478788454708 12:08:05 INFO - PROCESS | 1636 | __end_tp_report 12:08:05 INFO - PROCESS | 1636 | __start_cc_report 12:08:05 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,2145 12:08:05 INFO - PROCESS | 1636 | __end_cc_report 12:08:05 INFO - PROCESS | 1636 | __startTimestamp1487362085330__endTimestamp 12:08:05 INFO - PROCESS | 1636 | 12:08:05 INFO - PROCESS | 1636 | ------- Summary: start ------- 12:08:05 INFO - PROCESS | 1636 | Number of tests: 6 12:08:05 INFO - PROCESS | 1636 | 12:08:05 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5762.00 Median:6022.61 stddev:651.51 (10.8%) stddev-sans-first:619.52 12:08:05 INFO - PROCESS | 1636 | Values: 3114.4 3374.7 3380.9 3387.3 3433.2 5680.0 5695.7 5722.6 5746.2 5763.2 5484.8 5645.1 5714.1 5717.1 5754.0 5198.1 5250.3 5253.0 5276.3 5311.7 5186.9 5187.5 5198.3 5328.4 5341.7 5246.9 5260.8 5274.8 5288.8 5296.3 5294.4 5308.1 5310.1 5314.7 5328.9 5181.6 5262.3 5263.8 5271.0 5277.9 5561.9 5597.7 5609.7 5723.4 5730.5 5192.3 6197.4 6229.8 6305.5 6320.3 6226.1 6275.3 6287.6 6309.4 6313.9 5665.9 5805.3 5808.2 5845.8 5908.0 6234.5 6275.3 6287.4 6318.7 6326.2 6209.7 6212.3 6215.8 6217.4 6223.0 6246.0 6253.0 6286.7 6298.8 6300.7 6083.6 6124.4 6128.8 6134.8 6266.0 6214.8 6249.8 6263.0 6263.8 6266.9 4993.8 5000.1 5004.4 5024.8 5042.2 3649.7 4219.1 4297.7 4455.6 4495.2 5601.5 5727.5 5739.2 5748.2 5748.6 6223.7 6231.1 6234.0 6236.2 6236.2 5781.3 5862.3 5872.7 5874.9 5883.8 5448.4 5511.4 5515.8 5525.7 5530.3 6172.3 6218.6 6392.5 6397.2 6398.8 6246.5 6249.5 6250.1 6251.9 6255.2 6232.0 6240.3 6273.2 6352.0 6359.3 6217.7 6221.7 6222.3 6228.7 6243.5 6130.0 6208.3 6210.3 6230.0 6235.4 6026.7 6084.1 6117.4 6117.5 6132.2 6147.1 6177.4 6190.8 6191.4 6195.7 6022.6 6034.8 6041.7 6054.7 6088.3 5968.6 6015.8 6105.1 6118.6 6141.7 5775.1 5801.0 5816.6 6018.4 6052.7 12:08:05 INFO - PROCESS | 1636 | 12:08:05 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:71055.17 Median:36400.73 stddev:156545.29 (430.1%) stddev-sans-first:156894.67 12:08:05 INFO - PROCESS | 1636 | Values: 442.8 482.8 503.2 504.9 568.1 35838.0 41958.8 41986.7 42152.6 44041.8 43309.4 43568.0 43645.3 43691.0 43699.6 8440.7 9266.4 9452.0 9469.5 9489.7 8461.7 11212.7 11403.6 11497.3 11627.6 11356.6 11449.5 11450.8 11459.3 11460.0 11405.3 11472.5 11482.7 11497.7 11561.5 8431.6 8634.8 9431.0 11081.4 11298.3 41687.6 41988.8 42029.6 42078.8 42209.9 3856.5 3970.5 4012.6 4025.6 4031.1 27428.0 27434.6 27456.0 27680.4 28238.0 2883.5 3061.6 3141.1 3164.4 3165.0 463629.0 466118.0 466531.0 469858.0 471274.0 56325.2 56703.6 56720.0 56725.6 56829.0 58984.7 59029.8 59153.9 59168.8 59211.7 15602.3 15876.8 16124.8 16173.0 16183.9 11186.4 11480.1 12510.6 12644.1 12654.5 16106.6 18549.7 22063.7 22273.4 22506.8 8647.6 8734.4 8752.9 8861.4 8923.6 850.4 866.1 866.3 877.8 895.2 25261.9 26174.6 30761.0 31484.8 31509.9 994.3 1071.7 1071.7 1121.4 1131.6 15397.6 15937.7 15940.0 16044.8 16393.3 657122.0 660716.0 662392.0 662540.0 664317.0 63387.7 63671.4 63852.0 63926.7 64021.0 1423.4 1429.8 1459.4 1469.6 1471.6 25029.6 27757.7 29389.8 29582.4 29616.4 52505.4 53024.0 53167.9 53192.9 53225.7 603987.0 609944.0 610915.0 611129.0 611768.0 33350.7 33620.8 40339.8 40849.0 41072.0 41890.0 43432.3 43885.6 43921.3 44182.0 29127.3 32855.8 35027.5 35770.0 36278.0 35415.3 35546.5 36308.5 36493.0 36641.3 24761.9 34496.0 34972.7 35333.3 35941.9 25944.4 29760.1 31185.5 32080.4 32266.0 22261.7 23891.5 24302.5 24334.5 24455.9 12:08:05 INFO - PROCESS | 1636 | 12:08:05 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:40094.46 Median:21361.97 stddev:123702.25 (579.1%) stddev-sans-first:124013.25 12:08:05 INFO - PROCESS | 1636 | Values: 337.8 359.8 379.5 392.9 418.4 14788.6 15002.3 16753.2 20194.3 21025.9 19967.6 20537.8 20625.2 20849.9 21228.4 5184.3 5188.4 5415.7 5420.8 5425.5 5292.2 5434.8 5445.1 5446.0 5451.5 3879.2 4102.6 6022.2 6679.2 6711.9 6431.4 6653.8 6755.5 6768.7 6782.9 5924.2 5946.1 5952.4 5955.8 5958.7 13147.2 13207.2 13407.3 13458.3 20670.4 2483.5 2584.1 2950.2 2956.5 2958.9 7164.5 7168.0 7578.7 9847.8 10309.5 1774.6 1783.1 1783.6 1799.6 1799.9 123300.4 123606.0 125165.0 129835.0 130378.3 11134.7 11682.9 11685.6 11714.1 11872.9 14910.3 14931.7 15318.1 15320.8 15394.3 8410.6 8645.5 8681.6 8753.9 8762.0 7638.0 7664.9 8306.4 8416.4 8506.9 4522.8 4570.4 4665.4 4751.5 4760.4 1923.7 1972.5 1979.3 1988.8 1990.9 965.4 965.9 1001.5 1002.6 1019.0 20710.0 20932.7 21016.6 21070.0 21495.6 981.3 989.5 1013.0 1016.1 1025.6 9429.2 11057.8 11205.3 11208.7 11219.9 731182.0 736040.0 737331.0 752382.0 756904.2 144796.0 150238.0 150921.0 152671.5 157683.0 970.7 1017.5 1050.5 1050.6 1056.0 19370.4 19983.7 20134.2 20584.3 20687.5 59880.8 60358.0 61357.4 61564.7 62983.0 86776.3 87650.6 88175.6 88530.6 88546.0 8417.5 8448.9 8455.7 8518.2 8532.4 9320.1 10968.1 12789.6 13093.1 13658.3 9581.5 10290.5 10625.7 11103.6 11474.0 11235.8 11362.8 11522.5 11539.7 11779.0 9509.0 11136.1 11594.8 11666.7 11809.9 8315.9 8471.5 8561.4 8680.4 8776.2 10159.4 11180.6 11237.3 11280.8 11618.2 12:08:05 INFO - PROCESS | 1636 | 12:08:05 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5366.60 Median:5193.03 stddev:2909.57 (56.0%) stddev-sans-first:2902.71 12:08:05 INFO - PROCESS | 1636 | Values: 1432.4 1436.4 1453.1 1454.4 1460.5 6135.3 8424.0 8424.5 8432.2 8448.9 7320.3 7615.1 7619.1 7817.0 7913.8 2070.8 2336.0 2339.0 2342.9 2346.3 2327.8 2354.7 2366.6 2374.2 2378.0 2307.2 2317.2 2333.7 2340.4 2347.4 2261.5 2275.0 2292.1 2294.6 2303.9 2254.1 2284.2 2316.1 2317.0 2321.9 6948.7 8313.3 8332.3 8332.5 8352.2 5023.0 5192.6 5198.0 5202.7 5202.8 3181.6 3266.3 3441.6 3450.9 3454.8 1155.2 1178.5 1180.4 1182.9 1213.8 10668.8 10768.0 10784.6 10786.4 10797.9 4407.6 4624.5 4689.3 4723.9 4733.0 9396.3 9400.2 9423.9 9427.4 9433.0 5103.9 5193.4 5212.2 5220.1 5223.9 3933.2 4245.6 4370.3 4658.6 4781.6 3839.9 3845.8 3941.3 3952.6 4015.3 1278.3 1280.8 1283.6 1290.4 1295.1 778.1 844.0 903.9 915.0 921.1 5328.7 5405.3 5603.6 5713.6 5716.0 999.7 1004.3 1022.2 1032.7 1051.7 3021.0 3569.0 3640.4 3677.2 3855.5 9661.3 10007.0 10009.9 10022.4 10034.5 9821.0 9858.1 9934.4 9947.5 9961.3 6890.8 7576.3 7766.4 7807.8 7912.8 5631.5 5632.9 5722.2 5728.7 5799.3 8592.2 8597.0 8845.4 9060.3 9352.1 9126.6 9234.4 9392.8 9467.6 9553.9 6472.9 6549.8 6713.2 6957.2 7103.1 6675.7 7871.1 7876.3 8013.0 8022.2 6949.7 7117.8 7137.3 7225.0 7249.5 6957.1 6997.5 7057.5 7088.5 7114.0 6350.6 6373.1 6438.4 6451.1 6461.9 4870.6 4910.3 4946.0 4948.5 4974.9 3984.6 4931.0 5025.3 5090.5 5107.4 12:08:05 INFO - PROCESS | 1636 | 12:08:05 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4388.51 Median:4846.50 stddev:1323.42 (27.3%) stddev-sans-first:1291.43 12:08:05 INFO - PROCESS | 1636 | Values: 320.6 347.8 352.1 368.1 371.3 4363.7 5195.9 5283.1 5301.7 5324.4 4677.8 4694.4 4958.9 5126.2 5157.4 3292.4 4094.5 4124.6 4174.8 4201.5 3399.5 4154.6 4182.1 4192.2 4211.8 3775.7 4026.7 4078.5 4135.1 4170.5 4044.6 4063.2 4113.9 4123.9 4178.6 3351.7 3400.0 3457.9 3487.8 3565.6 4958.9 5115.9 5150.2 5157.9 5189.2 3835.9 4279.7 4564.2 4599.3 4649.5 4927.4 5414.5 5518.5 5592.5 5609.1 3351.3 3659.1 3851.7 3853.2 3870.0 5507.2 5796.9 5844.9 5859.4 5864.6 3343.6 3815.9 3826.4 3873.6 3880.7 3934.8 3943.2 3945.5 3955.2 3981.9 4045.6 4174.5 4327.9 4518.6 4604.2 5620.4 5630.9 5650.0 5654.9 5709.6 1120.5 1160.9 1259.6 1271.0 1279.3 717.9 726.5 775.2 841.4 850.3 4692.0 4775.5 4802.1 4820.9 4856.7 5366.2 5390.9 5448.7 5449.8 5455.5 4483.3 4795.6 4836.3 5143.3 5219.6 2567.7 2843.3 2869.7 2876.0 2882.8 5012.3 5176.5 5474.3 5477.5 5495.9 4736.6 5588.7 5594.5 5617.3 5648.3 4873.9 5608.8 5691.7 5707.7 5726.6 4871.3 4915.5 5060.6 5187.5 5454.3 4427.9 5333.7 5360.3 5432.6 5463.5 5054.2 5120.9 5317.5 5496.9 5730.3 3515.1 3517.4 3601.4 3654.6 3668.3 4659.5 4698.8 4731.6 5285.9 5413.5 4623.4 4728.7 5012.8 5294.5 5304.4 4240.9 5014.8 5057.7 5092.3 5162.5 4542.7 5235.2 5474.7 5476.6 5525.4 4525.8 5137.8 5447.4 5453.0 5461.4 4348.8 5284.0 5286.8 5447.3 5466.4 12:08:05 INFO - PROCESS | 1636 | 12:08:05 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:19906.15 Median:25430.12 stddev:28506.18 (112.1%) stddev-sans-first:28549.37 12:08:05 INFO - PROCESS | 1636 | Values: 622.8 645.2 722.0 813.3 825.0 14841.6 15767.0 15791.8 15793.2 15808.2 14085.9 14367.9 14493.6 14506.3 14513.9 680.0 842.5 856.6 858.6 861.7 695.2 704.4 831.5 849.1 870.8 912.3 914.4 914.5 916.2 917.1 910.7 912.1 912.1 912.3 913.4 529.1 544.9 644.8 661.8 662.3 15343.1 15358.4 15370.3 15382.2 15395.5 13726.7 13738.6 13800.9 13836.2 13878.7 11980.4 12083.5 12154.1 12585.2 12634.0 4267.8 4382.0 4450.8 4569.2 4605.7 94130.5 98800.0 101893.0 102226.0 102295.0 10546.8 10692.3 10835.2 11308.5 11548.9 22136.2 22370.6 22776.9 22854.0 22862.0 7603.2 7649.5 7741.3 7754.5 7911.6 4009.1 4026.4 4034.9 4107.4 4137.0 3486.9 3567.0 3575.5 3592.7 3607.3 627.0 631.5 632.3 643.1 645.8 610.6 622.4 637.6 638.8 645.3 7931.6 8263.7 9131.2 9628.0 9672.1 619.8 620.5 633.6 637.2 668.5 3857.7 4291.7 4672.6 4683.4 4690.1 93890.0 96705.0 99684.5 104842.0 105858.5 57453.3 73438.6 89901.1 91367.8 94040.0 78089.0 78319.0 79783.6 81056.2 81238.6 8687.6 9150.5 9187.0 9199.3 9256.4 42867.8 46254.5 50211.2 50544.0 51301.0 68425.0 68795.3 69231.0 70788.6 71193.3 7732.0 10971.4 11031.7 11457.9 12036.3 12070.1 12189.0 12233.4 12280.6 12610.9 11777.0 11973.3 11991.5 12836.8 13718.9 13120.0 13144.6 13363.0 13694.9 14111.2 12575.7 12897.3 13099.6 13169.0 13517.3 10952.7 10995.7 11195.3 11542.0 11681.8 8032.6 10775.5 10872.0 11327.5 11582.5 12:08:05 INFO - PROCESS | 1636 | -------- Summary: end -------- 12:08:05 INFO - PROCESS | 1636 | 12:08:06 INFO - TEST-INFO | 1636: exit 0 12:08:06 INFO - TEST-OK | dromaeo_css | took 1120586ms 12:08:06 INFO - TEST-START | kraken 12:08:06 INFO - operating with platform_type : mac_ 12:08:06 INFO - Initialising browser for kraken test... 12:08:06 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmplFW1KX/profile http://localhost:49244/getInfo.html) 12:08:08 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 12:08:08 INFO - PROCESS | 1647 | colorDepth:24 12:08:08 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 12:08:08 INFO - PROCESS | 1647 | __metrics 12:08:08 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:08:08 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:08:09 INFO - TEST-INFO | 1647: exit 0 12:08:09 INFO - Browser initialized. 12:08:09 INFO - Running cycle 1/1 for kraken test... 12:08:09 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmplFW1KX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:08:21 INFO - PROCESS | 1648 | RSS: Main: 213471232 12:08:21 INFO - PROCESS | 1648 | 12:08:24 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 12:08:25 INFO - PROCESS | 1648 | RSS: Main: 267071488 12:08:25 INFO - PROCESS | 1648 | 12:08:27 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 12:08:28 INFO - PROCESS | 1648 | RSS: Main: 276627456 12:08:28 INFO - PROCESS | 1648 | 12:08:31 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 12:08:31 INFO - PROCESS | 1648 | RSS: Main: 371920896 12:08:31 INFO - PROCESS | 1648 | 12:08:33 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 12:08:34 INFO - PROCESS | 1648 | RSS: Main: 274968576 12:08:34 INFO - PROCESS | 1648 | 12:08:36 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:08:37 INFO - PROCESS | 1648 | RSS: Main: 277315584 12:08:37 INFO - PROCESS | 1648 | 12:08:39 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 12:08:40 INFO - PROCESS | 1648 | RSS: Main: 317652992 12:08:40 INFO - PROCESS | 1648 | 12:08:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 12:08:44 INFO - PROCESS | 1648 | RSS: Main: 318136320 12:08:44 INFO - PROCESS | 1648 | 12:08:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 12:08:47 INFO - PROCESS | 1648 | RSS: Main: 316985344 12:08:47 INFO - PROCESS | 1648 | 12:08:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:08:49 INFO - PROCESS | 1648 | RSS: Main: 295030784 12:08:49 INFO - PROCESS | 1648 | 12:08:51 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:08:52 INFO - PROCESS | 1648 | RSS: Main: 297304064 12:08:52 INFO - PROCESS | 1648 | 12:08:54 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:08:55 INFO - PROCESS | 1648 | RSS: Main: 300580864 12:08:55 INFO - PROCESS | 1648 | 12:08:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:08:58 INFO - PROCESS | 1648 | RSS: Main: 315920384 12:08:58 INFO - PROCESS | 1648 | 12:09:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:09:02 INFO - PROCESS | 1648 | RSS: Main: 308793344 12:09:02 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 12:09:04 INFO - PROCESS | 1648 | RSS: Main: 353480704 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | __start_tp_report 12:09:04 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 12:09:04 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 12:09:04 INFO - PROCESS | 1648 | |i|pagename|runs| 12:09:04 INFO - PROCESS | 1648 | |0;ai-astar;115;114;114;110;113;114;114;113;111;114 12:09:04 INFO - PROCESS | 1648 | |1;audio-beat-detection;140;110;109;142;112;110;111;109;128;109 12:09:04 INFO - PROCESS | 1648 | |2;audio-dft;186;183;185;186;182;184;181;183;184;181 12:09:04 INFO - PROCESS | 1648 | |3;audio-fft;81;60;74;109;59;59;57;60;72;57 12:09:04 INFO - PROCESS | 1648 | |4;audio-oscillator;88;70;85;70;68;69;82;68;68;82 12:09:04 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;88;84;87;85;87;85;88;84;88;83 12:09:04 INFO - PROCESS | 1648 | |6;imaging-darkroom;93;94;95;96;95;113;126;142;109;95 12:09:04 INFO - PROCESS | 1648 | |7;imaging-desaturate;85;88;84;86;85;85;85;86;85;85 12:09:04 INFO - PROCESS | 1648 | |8;json-parse-financial;55;52;54;53;56;56;57;57;57;56 12:09:04 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;65;79;76;100;112;90;68;68;70;69 12:09:04 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;95;102;100;95;85;83;84;90;103;79 12:09:04 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;141;143;144;132;150;150;140;141;183;149 12:09:04 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;168;168;166;167;166;167;166;167;169;165 12:09:04 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;65;66;66;65;65;66;65;65;64;65 12:09:04 INFO - PROCESS | 1648 | __end_tp_report 12:09:04 INFO - PROCESS | 1648 | __start_cc_report 12:09:04 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2056 12:09:04 INFO - PROCESS | 1648 | __end_cc_report 12:09:04 INFO - PROCESS | 1648 | __startTimestamp1487362144367__endTimestamp 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | ------- Summary: start ------- 12:09:04 INFO - PROCESS | 1648 | Number of tests: 14 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.00 stddev:1.55 (1.4%) stddev-sans-first:1.50 12:09:04 INFO - PROCESS | 1648 | Values: 115.0 114.0 114.0 110.0 113.0 114.0 114.0 113.0 111.0 114.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:118.00 Median:111.50 stddev:13.40 (12.0%) stddev-sans-first:11.61 12:09:04 INFO - PROCESS | 1648 | Values: 140.0 110.0 109.0 142.0 112.0 110.0 111.0 109.0 128.0 109.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.00 stddev:1.84 (1.0%) stddev-sans-first:1.72 12:09:04 INFO - PROCESS | 1648 | Values: 186.0 183.0 185.0 186.0 182.0 184.0 181.0 183.0 184.0 181.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:68.80 Median:60.00 stddev:16.42 (27.4%) stddev-sans-first:16.82 12:09:04 INFO - PROCESS | 1648 | Values: 81.0 60.0 74.0 109.0 59.0 59.0 57.0 60.0 72.0 57.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.00 stddev:8.16 (10.7%) stddev-sans-first:7.18 12:09:04 INFO - PROCESS | 1648 | Values: 88.0 70.0 85.0 70.0 68.0 69.0 82.0 68.0 68.0 82.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:85.90 Median:87.00 stddev:1.91 (2.2%) stddev-sans-first:1.87 12:09:04 INFO - PROCESS | 1648 | Values: 88.0 84.0 87.0 85.0 87.0 85.0 88.0 84.0 88.0 83.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:105.80 Median:94.50 stddev:16.77 (17.7%) stddev-sans-first:17.13 12:09:04 INFO - PROCESS | 1648 | Values: 93.0 94.0 95.0 96.0 95.0 113.0 126.0 142.0 109.0 95.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 12:09:04 INFO - PROCESS | 1648 | Values: 85.0 88.0 84.0 86.0 85.0 85.0 85.0 86.0 85.0 85.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:1.77 (3.2%) stddev-sans-first:1.87 12:09:04 INFO - PROCESS | 1648 | Values: 55.0 52.0 54.0 53.0 56.0 56.0 57.0 57.0 57.0 56.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:79.70 Median:69.50 stddev:15.90 (22.9%) stddev-sans-first:15.95 12:09:04 INFO - PROCESS | 1648 | Values: 65.0 79.0 76.0 100.0 112.0 90.0 68.0 68.0 70.0 69.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:84.50 stddev:8.62 (10.2%) stddev-sans-first:9.05 12:09:04 INFO - PROCESS | 1648 | Values: 95.0 102.0 100.0 95.0 85.0 83.0 84.0 90.0 103.0 79.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:147.30 Median:146.50 stddev:13.70 (9.3%) stddev-sans-first:14.34 12:09:04 INFO - PROCESS | 1648 | Values: 141.0 143.0 144.0 132.0 150.0 150.0 140.0 141.0 183.0 149.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:167.00 stddev:1.20 (0.7%) stddev-sans-first:1.20 12:09:04 INFO - PROCESS | 1648 | Values: 168.0 168.0 166.0 167.0 166.0 167.0 166.0 167.0 169.0 165.0 12:09:04 INFO - PROCESS | 1648 | 12:09:04 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 12:09:04 INFO - PROCESS | 1648 | Values: 65.0 66.0 66.0 65.0 65.0 66.0 65.0 65.0 64.0 65.0 12:09:04 INFO - PROCESS | 1648 | -------- Summary: end -------- 12:09:04 INFO - PROCESS | 1648 | 12:09:05 INFO - TEST-INFO | 1648: exit 0 12:09:05 INFO - TEST-OK | kraken | took 59159ms 12:09:05 INFO - SUITE-END | took 1179s 12:09:05 INFO - Completed test suite (00:19:39) 12:09:05 INFO - javascript benchmark 12:09:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.408262430138, 3374.730021598274, 3380.8985730428067, 3387.2886693794303, 3433.193199598094, 5679.971600142004, 5695.658260504372, 5722.628029178106, 5746.195532625436, 5763.164341170528, 5484.7531861066245, 5645.125005624124, 5714.085746280596, 5717.085266357383, 5754.02181629123, 5198.116320225571, 5250.291210686566, 5252.973735131338, 5276.261323414725, 5311.654742441749, 5186.948130518703, 5187.455317191679, 5198.298229738974, 5328.413874473805, 5341.706206158659, 5246.8688282792855, 5260.8158714445, 5274.789008439658, 5288.814891478799, 5296.3379577552805, 5294.444083371229, 5308.097623404011, 5310.123829568117, 5314.654547454442, 5328.946710532903, 5181.585473162176, 5262.289590905255, 5263.842084737464, 5271.0248604008, 5277.947220527784, 5561.916571251434, 5597.692126933058, 5609.691466969315, 5723.370429252779, 5730.512906402961, 5192.299039629677, 6197.380261973812, 6229.781957631507, 6305.464035556983, 6320.304766475684, 6226.128342032119, 6275.2783429905685, 6287.591306565105, 6309.400606942333, 6313.873722525524, 5665.943340566624, 5805.3323867755325, 5808.186853840466, 5845.824625261249, 5908.0, 6234.501239900797, 6275.278342990615, 6287.434130928238, 6318.6524741138755, 6326.2092238470195, 6209.65846878417, 6212.254529456494, 6215.844603884939, 6217.378262173746, 6223.0354295084335, 6246.0, 6253.030780229072, 6286.654234017082, 6298.7795427160745, 6300.716467758962, 6083.6045657032155, 6124.360903754287, 6128.7893521635915, 6134.8346010261785, 6266.0, 6214.844628884314, 6249.78125765596, 6263.0, 6263.812085637438, 6266.874662506724, 4993.825216117419, 5000.1249781288125, 5004.399472063303, 5024.824131155465, 5042.2184561392305, 3649.6897763689853, 4219.135077309205, 4297.742135471882, 4455.554444555519, 4495.19086564415, 5601.495865372054, 5727.4845263926445, 5739.225204597409, 5748.166515855261, 5748.568857335633, 6223.657698826608, 6231.1276421300145, 6234.0025595905345, 6236.18929539157, 6236.220472440945, 5781.306243250837, 5862.296524417097, 5872.677002764804, 5874.94125058744, 5883.794067207627, 5448.37343705471, 5511.366192887789, 5515.779368825282, 5525.668459892419, 5530.281063461724, 6172.321044684992, 6218.626882387071, 6392.520560957947, 6397.200349956255, 6398.776042838478, 6246.5002799775, 6249.500039996698, 6250.0937364082865, 6251.9062214067735, 6255.155554000152, 6232.0, 6240.344763799736, 6273.153124328157, 6352.047192921099, 6359.300476947439, 6217.658028808459, 6221.720022598904, 6222.253329600477, 6228.719707613259, 6243.500519958483, 6130.0312685453755, 6208.317085120543, 6210.254769427517, 6230.034344676583, 6235.438810507076, 6026.668533230539, 6084.056971169476, 6117.449429551361, 6117.522930757332, 6132.233136608164, 6147.139400484025, 6177.413145751147, 6190.752369905334, 6191.411815877665, 6195.659238741732, 6022.608530445507, 6034.818955431344, 6041.69791510414, 6054.666993315233, 6088.26940767093, 5968.641881487125, 6015.789447369321, 6105.084237364431, 6118.649636126507, 6141.723622436912, 5775.104858746901, 5800.9848276552275, 5816.563757718103, 6018.36807135262, 6052.66710330936], "value": 5718.839317123648, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.7609091090811, 482.7857937287721, 503.18986431844723, 504.8741306885647, 568.0570253379391, 35838.0, 41958.790206049, 41986.74039778804, 42152.57847421521, 44041.779791101, 43309.35035974455, 43568.0, 43645.345319820226, 43691.0, 43699.56300436995, 8440.74677759665, 9266.397684150526, 9452.007539208387, 9469.526523673823, 9489.66786162481, 8461.746147615582, 11212.719682007973, 11403.600873969413, 11497.310161390302, 11627.593034243802, 11356.602518911839, 11449.542018319256, 11450.770984580304, 11459.312441253509, 11460.025897798698, 11405.258658187233, 11472.483738231758, 11482.712932176679, 11497.712557186054, 11561.479733412016, 8431.578421078983, 8634.784130396727, 9430.952845235799, 11081.390523521284, 11298.265612735146, 41687.583124168676, 41988.790056049525, 42029.57970420287, 42078.78960605208, 42209.944751381154, 3856.4606194888925, 3970.5235371755575, 4012.578679238696, 4025.5571887092397, 4031.072853243741, 27428.0, 27434.5884811728, 27456.0, 27680.446391072266, 28238.011669591466, 2883.4521440926155, 3061.586685797411, 3141.104785136225, 3164.4145833020734, 3164.984175079133, 463629.0, 466118.0, 466531.0, 469858.0, 471274.0, 56325.15512267319, 56703.58241044007, 56720.0, 56725.58186045382, 56829.0, 58984.70507647434, 59029.819403611684, 59153.8592298535, 59168.816623667284, 59211.70394148002, 15602.29789659468, 15876.761848572281, 16124.838751612333, 16173.029618222945, 16183.867129301072, 11186.440677966231, 11480.081593472501, 12510.562130325396, 12644.051696122828, 12654.493820247088, 16106.597335066717, 18549.74704890399, 22063.66904496434, 22273.44316392103, 22506.76212808311, 8647.567621618893, 8734.388592798443, 8752.91247087521, 8861.424007439497, 8923.643054277756, 850.4259624753266, 866.1035827918074, 866.3372520022189, 877.8018005422553, 895.1764376773255, 25261.87369063143, 26174.6073808893, 30761.0, 31484.842575786974, 31509.897153599515, 994.3487016004528, 1071.7052810477026, 1071.737424331044, 1121.4224674292745, 1131.6378758797107, 15397.615059623598, 15937.68124637524, 15940.043597384194, 16044.839551604568, 16393.34426622922, 657122.0, 660716.0, 662392.0, 662540.0, 664317.0, 63387.683061584394, 63671.36328636747, 63852.0, 63926.680366597866, 64021.0, 1423.352374669523, 1429.842717301096, 1459.37246983798, 1469.5811693667254, 1471.6247356923916, 25029.624555631315, 27757.722422775514, 29389.77586353175, 29582.408351833274, 29616.407671846013, 52505.42483725494, 53023.99999999846, 53167.936641266184, 53192.93614127773, 53225.7338713304, 603987.0, 609944.0, 610915.0, 611129.0, 611768.0, 33350.66649333476, 33620.82327118539, 40339.79830100948, 40849.0, 41072.0, 41890.0, 43432.34851477294, 43885.56114438815, 43921.34117988297, 44182.0, 29127.271818204714, 32855.83572082124, 35027.47458788171, 35770.0, 36278.0, 35415.29169416649, 35546.46680299849, 36308.455373168894, 36493.0, 36641.267174655826, 24761.876190618932, 34496.0, 34972.65027349694, 35333.29333413369, 35941.921742347775, 25944.351391214615, 29760.10719678413, 31185.53221701631, 32080.358392831546, 32266.0, 22261.666075009212, 23891.522169556858, 24302.51394972126, 24334.51330973406, 24455.877720611283], "value": 20230.770365821823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.7871940677373, 359.8236863936672, 379.5123266602416, 392.89195471245415, 418.36617524450446, 14788.6302842429, 15002.324895379707, 16753.246103925336, 20194.29319973801, 21025.894870525626, 19967.600647987067, 20537.794622053774, 20625.174993000262, 20849.853258070838, 21228.363149105513, 5184.300119483859, 5188.37739471264, 5415.702136382497, 5420.756065977021, 5425.457454254582, 5292.232626269189, 5434.809781657643, 5445.074337362638, 5445.9727701361435, 5451.536619387357, 3879.1853710720784, 4102.630763231308, 6022.187004754368, 6679.198496180441, 6711.899321510181, 6431.421172094534, 6653.7671181508895, 6755.459563234929, 6768.729250829961, 6782.864342713118, 5924.200232968537, 5946.108083787423, 5952.434518720715, 5955.761769529214, 5958.731857066442, 13147.211167329991, 13207.207567545978, 13407.329633518286, 13458.259795711232, 20670.379888603366, 2483.4784695214025, 2584.095566551711, 2950.173951293641, 2956.4826155422716, 2958.881644734208, 7164.498485106044, 7168.0, 7578.658960346797, 9847.753806154831, 10309.53607087683, 1774.6007148391639, 1783.1262681286075, 1783.6076063266062, 1799.5591080185438, 1799.9100044997829, 123300.38349808194, 123606.0, 125165.0, 129835.0, 130378.3481082598, 11134.659602119333, 11682.88317116818, 11685.591004314809, 11714.067178915384, 11872.88127118735, 14910.254487275593, 14931.70136597262, 15318.080915145127, 15320.770188447183, 15394.307256173499, 8410.621522031523, 8645.524496152646, 8681.56592170389, 8753.868691969625, 8762.0, 7638.0, 7664.923350766421, 8306.418550701394, 8416.368772341977, 8506.914930850737, 4522.806438877142, 4570.428696412949, 4665.4168228971375, 4751.501092385319, 4760.404949381327, 1923.6633589122127, 1972.4871533401133, 1979.2973494409566, 1988.77129130149, 1990.8905010224578, 965.4352203960622, 965.8599503072015, 1001.5442973447064, 1002.588938535197, 1018.9796204075877, 20710.0, 20932.686009709865, 21016.579668406546, 21070.0, 21495.57008859814, 981.3326937682302, 989.4854675568664, 1013.0, 1016.1413605503485, 1025.564135242519, 9429.198518125899, 11057.834132488018, 11205.271657342246, 11208.66374008781, 11219.943900280447, 731182.0, 736040.0, 737331.0, 752382.0, 756904.21547893, 144796.0, 150238.0, 150921.0, 152671.47328526794, 157683.0, 970.6893793985998, 1017.5421060522647, 1050.5062620568322, 1050.5745173204864, 1055.9683209503728, 19370.35351995096, 19983.700244496053, 20134.194632215134, 20584.27955021567, 20687.482812929196, 59880.80238395295, 60358.0, 61357.38642613517, 61564.69217653883, 62983.0, 86776.26447471141, 87650.56174719086, 88175.55912220398, 88530.55734721285, 88546.0, 8417.494950302756, 8448.873266901124, 8455.704050358208, 8518.211175653183, 8532.402731808714, 9320.067993200626, 10968.122550195805, 12789.61631151067, 13093.148945318524, 13658.317084145554, 9581.473018984023, 10290.485475726035, 10625.734356641145, 11103.5558577656, 11474.0, 11235.831462527905, 11362.829557556477, 11522.53909843597, 11539.711507212387, 11779.0, 9508.952455237679, 11136.053435458076, 11594.826077608674, 11666.650000499998, 11809.937105660532, 8315.916840831756, 8471.534065626449, 8561.44350617208, 8680.392372533863, 8776.16626420489, 10159.390436573829, 11180.608678696206, 11237.3257604544, 11280.830787538029, 11618.244814087057], "value": 9658.26577297305, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.4055516960461, 1436.432609119398, 1453.1499073042269, 1454.3528129982162, 1460.5034288341965, 6135.32511423743, 8423.957880210606, 8424.452410593314, 8432.156784321565, 8448.91551084489, 7320.341169294762, 7615.086189657235, 7619.085709714842, 7816.96091519543, 7913.841723165548, 2070.7929207079283, 2335.976640233593, 2338.9532209355802, 2342.8711420871846, 2346.2609278077352, 2327.8137748980125, 2354.693889794324, 2366.6331718583647, 2374.2165085521824, 2378.0368950575044, 2307.2040146149634, 2317.212147869724, 2333.6616190652344, 2340.3564019894493, 2347.377944844609, 2261.547690461906, 2274.965875511852, 2292.106078629336, 2294.598445272071, 2303.9308820735405, 2254.1096266974455, 2284.23478134825, 2316.073570571768, 2316.953660926772, 2321.8839058047197, 6948.652567371611, 8313.33493320533, 8332.33341332698, 8332.458390204678, 8352.206540378655, 5022.974885125587, 5192.636515443921, 5198.038362902875, 5202.68783872965, 5202.843914682566, 3181.618205815317, 3266.3304022675293, 3441.638627944055, 3450.9482357764655, 3454.827258637083, 1155.2375432214699, 1178.4932479034012, 1180.3626041937343, 1182.8876256755595, 1213.7511810079002, 10668.839967400496, 10768.0, 10784.5686172553, 10786.406747628876, 10797.892021079768, 4407.603315701603, 4624.5375462453485, 4689.343491911135, 4723.881902952385, 4733.0, 9396.342256042011, 9400.24798016157, 9423.869135703759, 9427.387219830689, 9433.009533998831, 5103.897922041612, 5193.428722840485, 5212.166053431509, 5220.060389129993, 5223.9477605223465, 3933.1740334529495, 4245.61789438952, 4370.322599997005, 4658.58072773452, 4781.617470602343, 3839.9232015360094, 3845.8269377878064, 3941.2905676977844, 3952.5652178260943, 4015.3374693175297, 1278.341654048166, 1280.801475771257, 1283.6277479531018, 1290.4193113098954, 1295.054610134607, 778.1479280188184, 844.0, 903.9141281578239, 914.9634014639473, 921.1111277616998, 5328.653637513549, 5405.270288511001, 5603.607747457639, 5713.628614140068, 5715.971420142872, 999.68010236725, 1004.2618675273668, 1022.1873610479687, 1032.70051685012, 1051.6529545250048, 3020.9546856797165, 3569.0, 3640.4346131163325, 3677.191017976041, 3855.4602355670227, 9661.32370734056, 10007.0, 10009.899901001043, 10022.448765317977, 10034.498275086216, 9820.950895245478, 9858.112769850604, 9934.354266972623, 9947.502624868728, 9961.252906032076, 6890.827729306707, 7576.28025337592, 7766.37868970481, 7807.765767026998, 7912.762617121495, 5631.465010824129, 5632.915506267491, 5722.17028530869, 5728.742206600629, 5799.304083509837, 8592.226699597066, 8596.968363796384, 8845.4250473719, 9060.275177985613, 9352.064793520865, 9126.634934602542, 9234.445933244027, 9392.81214375695, 9467.621295148117, 9553.904460955302, 6472.8705425890275, 6549.7707580236365, 6713.160854893138, 6957.1651401832105, 7103.147622285359, 6675.666216689243, 7871.134175240604, 7876.251756083163, 8013.0, 8022.197780221931, 6949.68726407323, 7117.82205444868, 7137.286271373029, 7225.0, 7249.456290778318, 6957.130358705162, 6997.545159564612, 7057.50597458173, 7088.503804733619, 7114.0396046535125, 6350.618962862243, 6373.107764913008, 6438.3883531064475, 6451.096846441408, 6461.935380646321, 4870.610351171827, 4910.3125562422, 4946.0355230729665, 4948.455669876383, 4974.925376119433, 3984.5816189300867, 4930.975345123252, 5025.321581586439, 5090.541851233407, 5107.387113546398], "value": 4385.85039069644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.6424836307517, 347.7756846833792, 352.12848200703263, 368.1403921842501, 371.3260432315346, 4363.672724545656, 5195.896082078366, 5283.128283833168, 5301.674581354661, 5324.429293358459, 4677.83627573035, 4694.38972933519, 4958.900821983558, 5126.154184559553, 5157.355330583677, 3292.3579901919134, 4094.529129150141, 4124.566920473352, 4174.833006679729, 4201.466464740378, 3399.490076488522, 4154.646855017327, 4182.142660754554, 4192.24539582875, 4211.768352740598, 3775.7356985010924, 4026.7047782763834, 4078.5309689385804, 4135.146748743373, 4170.47869016373, 4044.6157615026527, 4063.167050754588, 4113.8971525712095, 4123.938140927903, 4178.56125106864, 3351.731861451078, 3400.0, 3457.930841383158, 3487.843047062888, 3565.5608767084886, 4958.87602809929, 5115.948840511584, 5150.201718733602, 5157.871053223662, 5189.195674670432, 3835.9232815343817, 4279.679024073176, 4564.1556312082375, 4599.264117741145, 4649.511801260853, 4927.359443272351, 5414.512693857532, 5518.503334699856, 5592.5246354059955, 5609.083276696095, 3351.262722201112, 3659.0669379308106, 3851.691864650821, 3853.1715681128694, 3869.961300386988, 5507.200031977923, 5796.855078623026, 5844.94790937631, 5859.4433528815125, 5864.589478736448, 3343.598768147789, 3815.931539169037, 3826.392914975717, 3873.5545412277384, 3880.708946828999, 3934.8229329680235, 3943.191645712622, 3945.5265368155433, 3955.228730397545, 3981.92036159281, 4045.6358927696647, 4174.519930208005, 4327.870163895088, 4518.570735780096, 4604.217283061887, 5620.381758006616, 5630.887382252414, 5650.0, 5654.858628534237, 5709.571782116358, 1120.5181771838024, 1160.8897154770284, 1259.557806311768, 1270.9872901271053, 1279.251637791902, 717.8994940708305, 726.4769366056431, 775.2131586439768, 841.4026041510596, 850.2857599616352, 4691.9530804692195, 4775.450823155382, 4802.135615589157, 4820.903581928342, 4856.708597484162, 5366.163193316797, 5390.919136212881, 5448.700321482356, 5449.792833902276, 5455.453954929328, 4483.273939533303, 4795.640326975421, 4836.298736683161, 5143.305653736697, 5219.625070592871, 2567.7432256774173, 2843.3460304130167, 2869.741723244918, 2875.9856200718864, 2882.827030378184, 5012.3233363495465, 5176.456472070378, 5474.275603184984, 5477.507024367746, 5495.928293982635, 4736.573708366263, 5588.658721906713, 5594.496495315359, 5617.297837770278, 5648.260593612094, 4873.927735898097, 5608.803691870765, 5691.715414229355, 5707.6575405475805, 5726.627769194989, 4871.260252955414, 4915.508449155056, 5060.620453465931, 5187.4984385538855, 5454.290942177491, 4427.889302767457, 5333.7066461345, 5360.276362690986, 5432.56539476833, 5463.535599474089, 5054.194921818426, 5120.899006713575, 5317.548008419328, 5496.945030549803, 5730.326976293356, 3515.064920791168, 3517.43721004638, 3601.4057680483475, 3654.587971938508, 3668.3396988541253, 4659.510751371057, 4698.84878204842, 4731.574158325767, 5285.942811437651, 5413.5127838493145, 4623.42207224097, 4728.668993170445, 5012.8496145115705, 5294.49702278283, 5304.443033481429, 4240.943142575787, 5014.796448852322, 5057.671251368649, 5092.287079808903, 5162.457941916195, 4542.704724192917, 5235.1623740201385, 5474.713442341126, 5476.644018138808, 5525.4474552546035, 4525.773711314355, 5137.768800403916, 5447.428020057837, 5453.036906713659, 5461.399246083007, 4348.826046958086, 5284.0184930651, 5286.841394758163, 5447.264619276347, 5466.371367292653], "value": 3971.554120995937, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.7607061946727, 645.154847150233, 722.0, 813.3371302388554, 824.9628766705499, 14841.628959276024, 15767.0, 15791.842081579196, 15793.210339483023, 15808.209589520508, 14085.92957035216, 14367.856321436782, 14493.637659058502, 14506.274686265671, 14513.854861451382, 679.9932000679979, 842.4608250719529, 856.618804631939, 858.6007506509471, 861.7113267055544, 695.1935754524752, 704.3625518905374, 831.4678605692362, 849.0999540487103, 870.7953630896734, 912.2884150362728, 914.4239129348534, 914.501596629835, 916.2212119698237, 917.1287277086761, 910.6767097680328, 912.1243606138115, 912.1380295620642, 912.3066469483207, 913.4108500017452, 529.1427886823333, 544.861060429588, 644.8097811145723, 661.8279247395664, 662.3409707341178, 15343.07941523512, 15358.385664573403, 15370.308336124901, 15382.230888455533, 15395.461158859498, 13726.725465490634, 13738.587842364745, 13800.861991380058, 13836.169829810244, 13878.653033674138, 11980.400979950968, 12083.45624446902, 12154.149209555335, 12585.24488530691, 12634.0, 4267.765272909989, 4382.028087360701, 4450.799714012877, 4569.1547063793305, 4605.700629459075, 94130.52934735351, 98800.0, 101893.0, 102226.0, 102295.0, 10546.841797373045, 10692.305000174963, 10835.241533092609, 11308.49111789955, 11548.94225528867, 22136.225232116798, 22370.552588948456, 22776.886115569316, 22854.0, 22862.0, 7603.239676032353, 7649.464537482434, 7741.2645798650165, 7754.457187996899, 7911.564863932539, 4009.0730078018246, 4026.4362989181536, 4034.9148527465254, 4107.445494858216, 4136.9793151034055, 3486.930261394758, 3567.0, 3575.4994300797907, 3592.6946209571956, 3607.2785442911522, 626.9592476489014, 631.4948041566728, 632.3076231526563, 643.0868167202584, 645.7965740791635, 610.5725991805754, 622.3993845938691, 637.6014990630856, 638.7572722365471, 645.2676212498753, 7931.643076061591, 8263.669453221924, 9131.174790233783, 9627.951860240653, 9672.08115229052, 619.8202521268872, 620.534599050712, 633.6071635585967, 637.2416823979449, 668.5320275806955, 3857.7106716996336, 4291.661044730629, 4672.6261899047995, 4683.437987441461, 4690.132325519789, 93890.0, 96705.0329496696, 99684.50157749165, 104842.0, 105858.47070764597, 57453.27640170802, 73438.63280683562, 89901.10098898927, 91367.81063214941, 94040.0, 78089.0, 78319.0, 79783.60108199422, 81056.18943810604, 81238.59380703176, 8687.64572226246, 9150.542472876197, 9187.0, 9199.26405887514, 9256.398334108262, 42867.785661071495, 46254.537454625024, 50211.24683129683, 50544.0, 51301.0, 68425.0, 68795.31204687888, 69231.0, 70788.64605676939, 71193.28806711867, 7732.0, 10971.396573188551, 11031.669049928514, 11457.885421145682, 12036.277823330629, 12070.053409514347, 12189.0, 12233.388330583613, 12280.570180043656, 12610.873891261337, 11777.040013978409, 11973.281603103842, 11991.520339186334, 12836.807447888103, 13718.862811372157, 13120.015998799938, 13144.60566183016, 13362.964873727007, 13694.931525342708, 14111.22388268655, 12575.748485030064, 12897.290649014394, 13099.607011789662, 13169.02428185539, 13517.324133793467, 10952.726181845517, 10995.725106872393, 11195.2723073, 11542.0, 11681.766364672489, 8032.63853126599, 10775.461226938778, 10872.0, 11327.490262938023, 11582.478788454708], "value": 7298.093900787021, "unit": "score"}], "name": "dromaeo_css", "value": 7223.518453536913, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 110.0, 113.0, 114.0, 114.0, 113.0, 111.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 109.0, 142.0, 112.0, 110.0, 111.0, 109.0, 128.0, 109.0], "value": 118.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 183.0, 185.0, 186.0, 182.0, 184.0, 181.0, 183.0, 184.0, 181.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 74.0, 109.0, 59.0, 59.0, 57.0, 60.0, 72.0, 57.0], "value": 68.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 70.0, 68.0, 69.0, 82.0, 68.0, 68.0, 82.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 85.0, 87.0, 85.0, 88.0, 84.0, 88.0, 83.0], "value": 85.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 96.0, 95.0, 113.0, 126.0, 142.0, 109.0, 95.0], "value": 105.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 84.0, 86.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 54.0, 53.0, 56.0, 56.0, 57.0, 57.0, 57.0, 56.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 79.0, 76.0, 100.0, 112.0, 90.0, 68.0, 68.0, 70.0, 69.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 102.0, 100.0, 95.0, 85.0, 83.0, 84.0, 90.0, 103.0, 79.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 143.0, 144.0, 132.0, 150.0, 150.0, 140.0, 141.0, 183.0, 149.0], "value": 147.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 166.0, 167.0, 166.0, 167.0, 166.0, 167.0, 169.0, 165.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1441.6, "alertThreshold": 2.0}]} 12:09:05 INFO - Return code: 0 12:09:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:09:05 ERROR - # TBPL SUCCESS # 12:09:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:09:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:09:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:09:05 INFO - 2017-02-17 12:09:05.675 screenresolution[1652:9806] starting screenresolution argv=screenresolution get 12:09:05 INFO - 2017-02-17 12:09:05.679 screenresolution[1652:9806] Display 0: 1600x1200x32@60 12:09:05 INFO - 2017-02-17 12:09:05.685 screenresolution[1653:9809] starting screenresolution argv=screenresolution list 12:09:05 INFO - Available Modes on Display 0 12:09:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:09:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:09:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:09:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:09:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:09:05 INFO - Intel Iris: 12:09:05 INFO - Chipset Model: Intel Iris 12:09:05 INFO - Type: GPU 12:09:05 INFO - Bus: Built-In 12:09:05 INFO - VRAM (Dynamic, Max): 1536 MB 12:09:05 INFO - Vendor: Intel (0x8086) 12:09:05 INFO - Device ID: 0x0a2e 12:09:05 INFO - Revision ID: 0x0009 12:09:05 INFO - Displays: 12:09:05 INFO - Display: 12:09:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:09:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:09:05 INFO - Display Serial Number: 1600x1200 60 12:09:05 INFO - Main Display: Yes 12:09:05 INFO - Mirror: Off 12:09:05 INFO - Online: Yes 12:09:05 INFO - Rotation: Supported 12:09:05 INFO - Return code: 0 12:09:05 INFO - Running post-action listener: _resource_record_post_action 12:09:05 INFO - [mozharness: 2017-02-17 20:09:05.922580Z] Finished run-tests step (success) 12:09:05 INFO - Running post-run listener: _resource_record_post_run 12:09:05 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39138304; Write bytes: 507311616; Read time: 379; Write time: 2157 12:09:05 INFO - TinderboxPrint: CPU usage
53.6% 12:09:05 INFO - TinderboxPrint: I/O read bytes / time
39,138,304 / 379 12:09:05 INFO - TinderboxPrint: I/O write bytes / time
507,311,616 / 2,157 12:09:05 INFO - TinderboxPrint: CPU idle
2,227.9 (46.4%) 12:09:05 INFO - TinderboxPrint: CPU system
958.7 (20.0%) 12:09:05 INFO - TinderboxPrint: CPU user
1,615.0 (33.6%) 12:09:05 INFO - TinderboxPrint: Swap in / out
246,788,096 / 0 12:09:05 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205537792; Write bytes: 198877184; Read time: 15643; Write time: 384 12:09:05 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 37065728; Write bytes: 297465344; Read time: 356; Write time: 1741 12:09:06 INFO - Running post-run listener: _upload_blobber_files 12:09:06 INFO - Blob upload gear active. 12:09:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:09:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:09:06 INFO - (blobuploader) - INFO - Open directory for files ... 12:09:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:09:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:09:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:07 INFO - (blobuploader) - INFO - Done attempting. 12:09:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:09:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:09:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:08 INFO - (blobuploader) - INFO - Done attempting. 12:09:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:09:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:09 INFO - (blobuploader) - INFO - Done attempting. 12:09:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:09:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:09:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:09:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:09:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:09:11 INFO - (blobuploader) - INFO - Done attempting. 12:09:11 INFO - (blobuploader) - INFO - Iteration through files over. 12:09:12 INFO - Return code: 0 12:09:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:09:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:09:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bc8eff296e0d1135fcd9798c0fe5079a4e10a9bfceeaac0e318e453fda0e9292decc12ea428c4138666bd9093aa89807bc9b87ffaada8be4f44306fb5df9174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf39603e1e63e3750d63c605b05e782839618be6031d075af8c2586a36b2ab9c0ca924a77a35d153d337240108b1f60196cffec09efcb118be17b9b8cb3ee0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e0a779183142693b9dd6096c39abd1650505463f60d12dc44a1f09aa23688b65ee00354e34b97062f1dc90de6c743b3d06550b0fcd58660849dc25bd84a07ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/695d0e96ffb8be42dee773890086675de4a003f413c550761a0e0689b3b1094e0b0bab79091dab175d398bd4ee7c420fd8b01b7e689fd9968091dc69dc7cc45b"} 12:09:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:09:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:09:12 INFO - Contents: 12:09:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bc8eff296e0d1135fcd9798c0fe5079a4e10a9bfceeaac0e318e453fda0e9292decc12ea428c4138666bd9093aa89807bc9b87ffaada8be4f44306fb5df9174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf39603e1e63e3750d63c605b05e782839618be6031d075af8c2586a36b2ab9c0ca924a77a35d153d337240108b1f60196cffec09efcb118be17b9b8cb3ee0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e0a779183142693b9dd6096c39abd1650505463f60d12dc44a1f09aa23688b65ee00354e34b97062f1dc90de6c743b3d06550b0fcd58660849dc25bd84a07ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/695d0e96ffb8be42dee773890086675de4a003f413c550761a0e0689b3b1094e0b0bab79091dab175d398bd4ee7c420fd8b01b7e689fd9968091dc69dc7cc45b"} 12:09:12 INFO - Running post-run listener: copy_logs_to_upload_dir 12:09:12 INFO - Copying logs to upload dir... 12:09:12 INFO - mkdir: /builds/slave/test/build/upload/logs 12:09:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.013791 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-02-17 12:09:12.063299) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 12:09:12.066720) ========= 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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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/0bc8eff296e0d1135fcd9798c0fe5079a4e10a9bfceeaac0e318e453fda0e9292decc12ea428c4138666bd9093aa89807bc9b87ffaada8be4f44306fb5df9174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf39603e1e63e3750d63c605b05e782839618be6031d075af8c2586a36b2ab9c0ca924a77a35d153d337240108b1f60196cffec09efcb118be17b9b8cb3ee0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e0a779183142693b9dd6096c39abd1650505463f60d12dc44a1f09aa23688b65ee00354e34b97062f1dc90de6c743b3d06550b0fcd58660849dc25bd84a07ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/695d0e96ffb8be42dee773890086675de4a003f413c550761a0e0689b3b1094e0b0bab79091dab175d398bd4ee7c420fd8b01b7e689fd9968091dc69dc7cc45b"} build_url:https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011078 build_url: 'https://queue.taskcluster.net/v1/task/F8fFTVccSOCWjcSTT7-P_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bc8eff296e0d1135fcd9798c0fe5079a4e10a9bfceeaac0e318e453fda0e9292decc12ea428c4138666bd9093aa89807bc9b87ffaada8be4f44306fb5df9174", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/caf39603e1e63e3750d63c605b05e782839618be6031d075af8c2586a36b2ab9c0ca924a77a35d153d337240108b1f60196cffec09efcb118be17b9b8cb3ee0e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e0a779183142693b9dd6096c39abd1650505463f60d12dc44a1f09aa23688b65ee00354e34b97062f1dc90de6c743b3d06550b0fcd58660849dc25bd84a07ae", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/695d0e96ffb8be42dee773890086675de4a003f413c550761a0e0689b3b1094e0b0bab79091dab175d398bd4ee7c420fd8b01b7e689fd9968091dc69dc7cc45b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 12:09:12.101436) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 12:09:12.101781) ========= 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.VFdd0Cljf3/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.R4ZdV1cgKX/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.005221 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 12:09:12.150231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 12:09:12.150591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 12:09:12.150932) ========= ========= Total master_lag: 0.22 =========