builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0212 starttime: 1484252067.95 results: success (0) buildid: 20170112105515 builduid: 9e7a437b18c1488ca5fa9298a4b28fe3 revision: 6e5f04db4c4a95ad509224b238fd3ad464281e6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:27.945513) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:27.946020) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:27.946322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:27.972854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:27.973243) ========= 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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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-01-12 12:14:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 69.5M=0s 2017-01-12 12:14:28 (69.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.103833 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:28.101071) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:28.101382) ========= 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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.025440 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:28.149527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:28.149885) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6e5f04db4c4a95ad509224b238fd3ad464281e6b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6e5f04db4c4a95ad509224b238fd3ad464281e6b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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-01-12 12:14:28,250 truncating revision to first 12 chars 2017-01-12 12:14:28,250 Setting DEBUG logging. 2017-01-12 12:14:28,250 attempt 1/10 2017-01-12 12:14:28,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6e5f04db4c4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 12:14:28,872 unpacking tar archive at: mozilla-central-6e5f04db4c4a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.896765 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:29.072965) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:29.073511) ========= script_repo_revision: 6e5f04db4c4a95ad509224b238fd3ad464281e6b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:29.074294) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:29.074835) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 12:14:29.096564) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-12 12:14:29.097247) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:14:29 INFO - MultiFileLogger online at 20170112 12:14:29 in /builds/slave/test 12:14:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:14:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:14:29 INFO - {'append_to_log': False, 12:14:29 INFO - 'base_work_dir': '/builds/slave/test', 12:14:29 INFO - 'blob_upload_branch': 'Firefox', 12:14:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:14:29 INFO - 'branch': 'Firefox', 12:14:29 INFO - 'buildbot_json_path': 'buildprops.json', 12:14:29 INFO - 'config_files': ('talos/mac_config.py',), 12:14:29 INFO - 'default_actions': ('clobber', 12:14:29 INFO - 'read-buildbot-config', 12:14:29 INFO - 'download-and-extract', 12:14:29 INFO - 'populate-webroot', 12:14:29 INFO - 'create-virtualenv', 12:14:29 INFO - 'install', 12:14:29 INFO - 'run-tests'), 12:14:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:14:29 INFO - 'download_minidump_stackwalk': True, 12:14:29 INFO - 'download_symbols': 'ondemand', 12:14:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:14:29 INFO - 'tooltool.py': '/tools/tooltool.py', 12:14:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:14:29 INFO - '/tools/misc-python/virtualenv.py')}, 12:14:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:14:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:14:29 INFO - 'installer_path': 'installer.exe', 12:14:29 INFO - 'log_level': 'info', 12:14:29 INFO - 'log_name': 'talos', 12:14:29 INFO - 'log_to_console': True, 12:14:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:14:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:14:29 INFO - 'opt_config_files': (), 12:14:29 INFO - 'pip_index': False, 12:14:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:14:29 INFO - 'cmd': ('bash', 12:14:29 INFO - '-c', 12:14:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:14:29 INFO - 'enabled': True, 12:14:29 INFO - 'halt_on_failure': False, 12:14:29 INFO - 'name': 'check_screen_resolution'},), 12:14:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:14:29 INFO - 'cmd': ('bash', 12:14:29 INFO - '-c', 12:14:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:14:29 INFO - 'enabled': True, 12:14:29 INFO - 'halt_on_failure': False, 12:14:29 INFO - 'name': 'check_screen_resolution'},), 12:14:29 INFO - 'run_cmd_checks_enabled': True, 12:14:29 INFO - 'sps_profile': False, 12:14:29 INFO - 'sps_profile_interval': 0, 12:14:29 INFO - 'suite': 'dromaeojs', 12:14:29 INFO - 'system_bits': '32', 12:14:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:14:29 INFO - 'title': 't-yosemite-r7-0212', 12:14:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:14:29 INFO - 'use_talos_json': True, 12:14:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:14:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:14:29 INFO - 'work_dir': 'build'} 12:14:29 INFO - [mozharness: 2017-01-12 20:14:29.305238Z] Running clobber step. 12:14:29 INFO - Running pre-action listener: _resource_record_pre_action 12:14:29 INFO - Running main action method: clobber 12:14:29 INFO - rmtree: /builds/slave/test/build 12:14:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:14:31 INFO - Running post-action listener: _resource_record_post_action 12:14:31 INFO - [mozharness: 2017-01-12 20:14:31.660413Z] Finished clobber step (success) 12:14:31 INFO - [mozharness: 2017-01-12 20:14:31.660706Z] Running read-buildbot-config step. 12:14:31 INFO - Running pre-action listener: _resource_record_pre_action 12:14:31 INFO - Running main action method: read_buildbot_config 12:14:31 INFO - Using buildbot properties: 12:14:31 INFO - { 12:14:31 INFO - "project": "", 12:14:31 INFO - "product": "firefox", 12:14:31 INFO - "script_repo_revision": "production", 12:14:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 12:14:31 INFO - "repository": "", 12:14:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 12:14:31 INFO - "buildid": "20170112105515", 12:14:31 INFO - "pgo_build": "False", 12:14:31 INFO - "basedir": "/builds/slave/test", 12:14:31 INFO - "buildnumber": 114, 12:14:31 INFO - "slavename": "t-yosemite-r7-0212", 12:14:31 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:14:31 INFO - "platform": "yosemite_r7", 12:14:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:14:31 INFO - "branch": "mozilla-central", 12:14:31 INFO - "repo_path": "mozilla-central", 12:14:31 INFO - "revision": "6e5f04db4c4a95ad509224b238fd3ad464281e6b", 12:14:31 INFO - "stage_platform": "macosx64", 12:14:31 INFO - "builduid": "9e7a437b18c1488ca5fa9298a4b28fe3", 12:14:31 INFO - "slavebuilddir": "test" 12:14:31 INFO - } 12:14:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 12:14:31 INFO - Running post-action listener: _resource_record_post_action 12:14:31 INFO - [mozharness: 2017-01-12 20:14:31.666552Z] Finished read-buildbot-config step (success) 12:14:31 INFO - [mozharness: 2017-01-12 20:14:31.666762Z] Running download-and-extract step. 12:14:31 INFO - Running pre-action listener: _resource_record_pre_action 12:14:31 INFO - Running main action method: download_and_extract 12:14:31 INFO - mkdir: /builds/slave/test/build/tests 12:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:31 INFO - trying https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 12:14:31 INFO - Downloading https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 12:14:32 INFO - Downloaded 1199 bytes. 12:14:32 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 12:14:32 INFO - Using the following test package requirements: 12:14:32 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:14:32 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:14:32 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 12:14:32 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:14:32 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 12:14:32 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:14:32 INFO - u'jsshell-mac.zip'], 12:14:32 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:14:32 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 12:14:32 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 12:14:32 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:14:32 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 12:14:32 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:14:32 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 12:14:32 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:14:32 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 12:14:32 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 12:14:32 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 12:14:32 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:14:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:14:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:14:32 INFO - Fetch https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:14:33 INFO - Expected file size: 16314280 12:14:33 INFO - Obtained file size: 16314280 12:14:40 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:14:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 12:14:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:14:40 INFO - Fetch https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 12:14:41 INFO - Expected file size: 16314280 12:14:41 INFO - Obtained file size: 16314280 12:14:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 12:14:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:14:47 INFO - Fetch https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 12:14:49 INFO - Expected file size: 14403532 12:14:49 INFO - Obtained file size: 14403532 12:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:49 INFO - trying https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:14:49 INFO - Downloading https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 12:14:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 12:14:51 INFO - Downloaded 70132899 bytes. 12:14:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:14:51 INFO - mkdir: /builds/slave/test/properties 12:14:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:51 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:51 INFO - Contents: 12:14:51 INFO - build_url:https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 12:14:52 INFO - Running post-action listener: _resource_record_post_action 12:14:52 INFO - Running post-action listener: set_extra_try_arguments 12:14:52 INFO - [mozharness: 2017-01-12 20:14:52.377450Z] Finished download-and-extract step (success) 12:14:52 INFO - [mozharness: 2017-01-12 20:14:52.377600Z] Running populate-webroot step. 12:14:52 INFO - Running pre-action listener: _resource_record_pre_action 12:14:52 INFO - Running main action method: populate_webroot 12:14:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:52 INFO - '--tppagecycles', 12:14:52 INFO - '7'], 12:14:52 INFO - 'tests': ['tsvgm']}}, 12:14:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:14:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:14:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:14:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:14:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:14:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:14:52 INFO - 'talos_options': ['--disable-e10s'], 12:14:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:14:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:14:52 INFO - 'talos_options': ['--disable-e10s'], 12:14:52 INFO - 'tests': ['damp', 'tps']}, 12:14:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:14:52 INFO - 'tests': ['damp', 'tps']}, 12:14:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:14:52 INFO - 'tests': ['dromaeo_dom']}, 12:14:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:14:52 INFO - 'tests': ['basic_compositor_video']}, 12:14:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:14:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:14:52 INFO - 'tests': ['a11yr', 12:14:52 INFO - 'ts_paint', 12:14:52 INFO - 'tpaint', 12:14:52 INFO - 'sessionrestore', 12:14:52 INFO - 'sessionrestore_no_auto_restore', 12:14:52 INFO - 'tabpaint']}, 12:14:52 INFO - 'other-e10s': {'tests': ['a11yr', 12:14:52 INFO - 'ts_paint', 12:14:52 INFO - 'tpaint', 12:14:52 INFO - 'sessionrestore', 12:14:52 INFO - 'sessionrestore_no_auto_restore', 12:14:52 INFO - 'tabpaint']}, 12:14:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:14:52 INFO - 'ts_paint', 12:14:52 INFO - 'tpaint', 12:14:52 INFO - 'sessionrestore', 12:14:52 INFO - 'sessionrestore_no_auto_restore', 12:14:52 INFO - 'tabpaint']}, 12:14:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:14:52 INFO - 'ts_paint', 12:14:52 INFO - 'tpaint', 12:14:52 INFO - 'sessionrestore', 12:14:52 INFO - 'sessionrestore_no_auto_restore', 12:14:52 INFO - 'tabpaint']}, 12:14:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:14:52 INFO - 'tests': ['a11yr', 12:14:52 INFO - 'ts_paint', 12:14:52 INFO - 'tpaint', 12:14:52 INFO - 'sessionrestore', 12:14:52 INFO - 'sessionrestore_no_auto_restore', 12:14:52 INFO - 'tabpaint']}, 12:14:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:14:52 INFO - 'tests': ['a11yr', 12:14:52 INFO - 'ts_paint', 12:14:52 INFO - 'tpaint', 12:14:52 INFO - 'sessionrestore', 12:14:52 INFO - 'sessionrestore_no_auto_restore', 12:14:52 INFO - 'tabpaint']}, 12:14:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:14:52 INFO - 'tests': ['tsvgx', 12:14:52 INFO - 'tsvgr_opacity', 12:14:52 INFO - 'tart', 12:14:52 INFO - 'tscrollx', 12:14:52 INFO - 'cart', 12:14:52 INFO - 'tsvg_static']}, 12:14:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:14:52 INFO - 'tsvgr_opacity', 12:14:52 INFO - 'tart', 12:14:52 INFO - 'tscrollx', 12:14:52 INFO - 'cart', 12:14:52 INFO - 'tsvg_static']}, 12:14:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:14:52 INFO - 'talos_options': ['--disable-e10s'], 12:14:52 INFO - 'tests': ['tp5o']}, 12:14:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:14:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:14:52 INFO - 'talos_options': ['--disable-e10s', 12:14:52 INFO - '--xperf_path', 12:14:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:52 INFO - 'tests': ['tp5n']}, 12:14:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:14:52 INFO - 'talos_options': ['--xperf_path', 12:14:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:52 INFO - 'tests': ['tp5n']}}, 12:14:52 INFO - 'talos.zip': {'path': '', 12:14:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:52 INFO - Running post-action listener: _resource_record_post_action 12:14:52 INFO - [mozharness: 2017-01-12 20:14:52.396214Z] Finished populate-webroot step (success) 12:14:52 INFO - [mozharness: 2017-01-12 20:14:52.396322Z] Running create-virtualenv step. 12:14:52 INFO - Running pre-action listener: _resource_record_pre_action 12:14:52 INFO - Running main action method: create_virtualenv 12:14:52 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:14:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:52 INFO - Using real prefix '/tools/python27' 12:14:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:53 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:56 INFO - Installing pip.................done. 12:14:56 INFO - Return code: 0 12:14:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:14:56 INFO - Reading from file tmpfile_stdout 12:14:56 INFO - Output received: 12:14:56 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) 12:14:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ff0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c70579cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dced30>, '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 0x100cf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dc3be8>, '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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq4W9Tp634/Render', 12:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:56 INFO - 'HOME': '/Users/cltbld', 12:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:56 INFO - 'LOGNAME': 'cltbld', 12:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:56 INFO - 'MOZ_NO_REMOTE': '1', 12:14:56 INFO - 'NO_EM_RESTART': '1', 12:14:56 INFO - 'PAGER': '/bin/cat', 12:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:56 INFO - 'PWD': '/builds/slave/test', 12:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:56 INFO - 'SHELL': '/bin/bash', 12:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iwjl1CuJQc/Listeners', 12:14:56 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 12:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:56 INFO - 'USER': 'cltbld', 12:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:56 INFO - 'XPC_FLAGS': '0x0', 12:14:56 INFO - 'XPC_SERVICE_NAME': '0', 12:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:14:56 INFO - Cleaning up... 12:14:56 INFO - Return code: 0 12:14:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100ff0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c70579cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dced30>, '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 0x100cf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dc3be8>, '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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq4W9Tp634/Render', 12:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:14:56 INFO - 'HOME': '/Users/cltbld', 12:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:14:56 INFO - 'LOGNAME': 'cltbld', 12:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:56 INFO - 'MOZ_NO_REMOTE': '1', 12:14:56 INFO - 'NO_EM_RESTART': '1', 12:14:56 INFO - 'PAGER': '/bin/cat', 12:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:56 INFO - 'PWD': '/builds/slave/test', 12:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:14:56 INFO - 'SHELL': '/bin/bash', 12:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iwjl1CuJQc/Listeners', 12:14:56 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 12:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:14:56 INFO - 'USER': 'cltbld', 12:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:56 INFO - 'XPC_FLAGS': '0x0', 12:14:56 INFO - 'XPC_SERVICE_NAME': '0', 12:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:57 INFO - Downloading/unpacking psutil>=3.1.1 12:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:00 INFO - Installing collected packages: psutil 12:15:00 INFO - Running setup.py install for psutil 12:15:00 INFO - building 'psutil._psutil_osx' extension 12:15:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:15:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:15:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:15:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:15:01 INFO - building 'psutil._psutil_posix' extension 12:15:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:15:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:15:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:15:01 INFO - ^ 12:15:01 INFO - 1 warning generated. 12:15:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:15:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:01 INFO - Successfully installed psutil 12:15:01 INFO - Cleaning up... 12:15:01 INFO - Return code: 0 12:15:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:01 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 0x100ff0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c70579cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dced30>, '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 0x100cf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dc3be8>, '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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:15:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq4W9Tp634/Render', 12:15:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:01 INFO - 'HOME': '/Users/cltbld', 12:15:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:01 INFO - 'LOGNAME': 'cltbld', 12:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:01 INFO - 'MOZ_NO_REMOTE': '1', 12:15:01 INFO - 'NO_EM_RESTART': '1', 12:15:01 INFO - 'PAGER': '/bin/cat', 12:15:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:01 INFO - 'PWD': '/builds/slave/test', 12:15:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:01 INFO - 'SHELL': '/bin/bash', 12:15:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iwjl1CuJQc/Listeners', 12:15:01 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 12:15:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:01 INFO - 'USER': 'cltbld', 12:15:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:01 INFO - 'XPC_FLAGS': '0x0', 12:15:01 INFO - 'XPC_SERVICE_NAME': '0', 12:15:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:15:04 INFO - Installing collected packages: mozsystemmonitor 12:15:04 INFO - Running setup.py install for mozsystemmonitor 12:15:04 INFO - Successfully installed mozsystemmonitor 12:15:04 INFO - Cleaning up... 12:15:04 INFO - Return code: 0 12:15:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ff0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c70579cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dced30>, '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 0x100cf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dc3be8>, '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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15: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==2.5.1'] in /builds/slave/test/build 12:15: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==2.5.1 12:15:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq4W9Tp634/Render', 12:15:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:04 INFO - 'HOME': '/Users/cltbld', 12:15:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:04 INFO - 'LOGNAME': 'cltbld', 12:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:04 INFO - 'MOZ_NO_REMOTE': '1', 12:15:04 INFO - 'NO_EM_RESTART': '1', 12:15:04 INFO - 'PAGER': '/bin/cat', 12:15:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:04 INFO - 'PWD': '/builds/slave/test', 12:15:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:04 INFO - 'SHELL': '/bin/bash', 12:15:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iwjl1CuJQc/Listeners', 12:15:04 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 12:15:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:04 INFO - 'USER': 'cltbld', 12:15:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:04 INFO - 'XPC_FLAGS': '0x0', 12:15:04 INFO - 'XPC_SERVICE_NAME': '0', 12:15:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:05 INFO - Downloading/unpacking jsonschema==2.5.1 12:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:08 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:08 INFO - warning: no files found matching '*.txt' 12:15:08 INFO - no previously-included directories found matching 'build' 12:15:08 INFO - no previously-included directories found matching 'dist' 12:15:08 INFO - no previously-included directories found matching '.git*' 12:15:08 INFO - Installing collected packages: jsonschema, functools32 12:15:08 INFO - Running setup.py install for functools32 12:15:08 INFO - warning: no files found matching '*.txt' 12:15:08 INFO - no previously-included directories found matching 'build' 12:15:08 INFO - no previously-included directories found matching 'dist' 12:15:08 INFO - no previously-included directories found matching '.git*' 12:15:08 INFO - Successfully installed jsonschema functools32 12:15:08 INFO - Cleaning up... 12:15:08 INFO - Return code: 0 12:15:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100ff0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c70579cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dced30>, '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 0x100cf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dc3be8>, '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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:15:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq4W9Tp634/Render', 12:15:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:08 INFO - 'HOME': '/Users/cltbld', 12:15:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:08 INFO - 'LOGNAME': 'cltbld', 12:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:08 INFO - 'MOZ_NO_REMOTE': '1', 12:15:08 INFO - 'NO_EM_RESTART': '1', 12:15:08 INFO - 'PAGER': '/bin/cat', 12:15:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:08 INFO - 'PWD': '/builds/slave/test', 12:15:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:08 INFO - 'SHELL': '/bin/bash', 12:15:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iwjl1CuJQc/Listeners', 12:15:08 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 12:15:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:08 INFO - 'USER': 'cltbld', 12:15:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:08 INFO - 'XPC_FLAGS': '0x0', 12:15:08 INFO - 'XPC_SERVICE_NAME': '0', 12:15:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:15:08 INFO - Cleaning up... 12:15:08 INFO - Return code: 0 12:15:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ff0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c70579cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dced30>, '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 0x100cf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dc3be8>, '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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:15:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq4W9Tp634/Render', 12:15:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:08 INFO - 'HOME': '/Users/cltbld', 12:15:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:08 INFO - 'LOGNAME': 'cltbld', 12:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:08 INFO - 'MOZ_NO_REMOTE': '1', 12:15:08 INFO - 'NO_EM_RESTART': '1', 12:15:08 INFO - 'PAGER': '/bin/cat', 12:15:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:08 INFO - 'PWD': '/builds/slave/test', 12:15:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:08 INFO - 'SHELL': '/bin/bash', 12:15:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iwjl1CuJQc/Listeners', 12:15:08 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 12:15:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:08 INFO - 'USER': 'cltbld', 12:15:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:08 INFO - 'XPC_FLAGS': '0x0', 12:15:08 INFO - 'XPC_SERVICE_NAME': '0', 12:15:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:08 INFO - Downloading/unpacking blobuploader==1.2.4 12:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:11 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:12 INFO - Downloading docopt-0.6.1.tar.gz 12:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:15:12 INFO - Installing collected packages: blobuploader, requests, docopt 12:15:12 INFO - Running setup.py install for blobuploader 12:15:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:15:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:15:13 INFO - Running setup.py install for requests 12:15:13 INFO - Running setup.py install for docopt 12:15:13 INFO - Successfully installed blobuploader requests docopt 12:15:13 INFO - Cleaning up... 12:15:13 INFO - Return code: 0 12:15:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ff0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c70579cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dced30>, '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 0x100cf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dc3be8>, '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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:15:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq4W9Tp634/Render', 12:15:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:13 INFO - 'HOME': '/Users/cltbld', 12:15:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:13 INFO - 'LOGNAME': 'cltbld', 12:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:13 INFO - 'MOZ_NO_REMOTE': '1', 12:15:13 INFO - 'NO_EM_RESTART': '1', 12:15:13 INFO - 'PAGER': '/bin/cat', 12:15:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:13 INFO - 'PWD': '/builds/slave/test', 12:15:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:13 INFO - 'SHELL': '/bin/bash', 12:15:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iwjl1CuJQc/Listeners', 12:15:13 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 12:15:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:13 INFO - 'USER': 'cltbld', 12:15:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:13 INFO - 'XPC_FLAGS': '0x0', 12:15:13 INFO - 'XPC_SERVICE_NAME': '0', 12:15:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:14 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-jkMt13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:14 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-UcMm8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:14 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-v2Hwv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:14 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-tsntdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:14 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-T4cTon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:14 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-z1HOXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:14 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-uBvqTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:14 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-pLlQg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:14 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-3x6XHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:15 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-zrnPE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:15 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-gS7bA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:15 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-ogWPaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:15 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-dR1tvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:15 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-GtyHHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:15 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-eDouOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:15 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-6okpBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:15 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-PIgj9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:15:15 INFO - Running setup.py install for manifestparser 12:15:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:15:16 INFO - Running setup.py install for mozcrash 12:15:16 INFO - Running setup.py install for mozdebug 12:15:16 INFO - Running setup.py install for mozdevice 12:15:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:15:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:15:16 INFO - Running setup.py install for mozfile 12:15:16 INFO - Running setup.py install for mozhttpd 12:15:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:15:16 INFO - Running setup.py install for mozinfo 12:15:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:15:16 INFO - Running setup.py install for mozInstall 12:15:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:15:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:15:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:15:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:15:17 INFO - Running setup.py install for mozleak 12:15:17 INFO - Running setup.py install for mozlog 12:15:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:15:17 INFO - Running setup.py install for moznetwork 12:15:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:15:17 INFO - Running setup.py install for mozprocess 12:15:17 INFO - Running setup.py install for mozprofile 12:15:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:15:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:15:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:15:17 INFO - Running setup.py install for mozrunner 12:15:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:15:18 INFO - Running setup.py install for mozscreenshot 12:15:18 INFO - Running setup.py install for moztest 12:15:18 INFO - Running setup.py install for mozversion 12:15:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:15:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:15:18 INFO - Cleaning up... 12:15:18 INFO - Return code: 0 12:15:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:18 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 0x100ff0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c70579cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dced30>, '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 0x100cf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dc3be8>, '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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:15:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq4W9Tp634/Render', 12:15:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:18 INFO - 'HOME': '/Users/cltbld', 12:15:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:18 INFO - 'LOGNAME': 'cltbld', 12:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:18 INFO - 'MOZ_NO_REMOTE': '1', 12:15:18 INFO - 'NO_EM_RESTART': '1', 12:15:18 INFO - 'PAGER': '/bin/cat', 12:15:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:18 INFO - 'PWD': '/builds/slave/test', 12:15:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:18 INFO - 'SHELL': '/bin/bash', 12:15:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iwjl1CuJQc/Listeners', 12:15:18 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 12:15:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:18 INFO - 'USER': 'cltbld', 12:15:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:18 INFO - 'XPC_FLAGS': '0x0', 12:15:18 INFO - 'XPC_SERVICE_NAME': '0', 12:15:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:18 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-F48a_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:18 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-bfqHIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:18 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)) 12:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:18 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-_Gm96_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:19 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-QrgC9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:19 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)) 12:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:19 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-YFDqOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:19 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-fqUhQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:19 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-SD3HqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:19 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-UgVkuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:19 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-OAXmUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:19 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Hiby45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:19 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-OifWlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:19 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-fV8fEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:19 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)) 12:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:19 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-__w9xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:20 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-v6flp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:20 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)) 12:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:20 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-SPR3N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:20 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-ciQsmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:20 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)) 12:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:20 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-OFGtgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:15:20 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)) 12:15:20 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)) 12:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:15:20 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)) 12:15:20 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)) 12:15:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:23 INFO - Downloading blessings-1.6.tar.gz 12:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:15:23 INFO - Installing collected packages: blessings 12:15:23 INFO - Running setup.py install for blessings 12:15:23 INFO - Successfully installed blessings 12:15:23 INFO - Cleaning up... 12:15:23 INFO - Return code: 0 12:15:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:23 INFO - Reading from file tmpfile_stdout 12:15:23 INFO - Current package versions: 12:15:23 INFO - blessings == 1.6 12:15:23 INFO - blobuploader == 1.2.4 12:15:23 INFO - docopt == 0.6.1 12:15:23 INFO - functools32 == 3.2.3-2 12:15:23 INFO - jsonschema == 2.5.1 12:15:23 INFO - manifestparser == 1.1 12:15:23 INFO - mozInstall == 1.12 12:15:23 INFO - mozcrash == 1.0 12:15:23 INFO - mozdebug == 0.1 12:15:23 INFO - mozdevice == 0.49 12:15:23 INFO - mozfile == 1.2 12:15:23 INFO - mozhttpd == 0.7 12:15:23 INFO - mozinfo == 0.9 12:15:23 INFO - mozleak == 0.1 12:15:23 INFO - mozlog == 3.4 12:15:23 INFO - moznetwork == 0.27 12:15:23 INFO - mozprocess == 0.24 12:15:23 INFO - mozprofile == 0.28 12:15:23 INFO - mozrunner == 6.13 12:15:23 INFO - mozscreenshot == 0.1 12:15:23 INFO - mozsystemmonitor == 0.3 12:15:23 INFO - moztest == 0.8 12:15:23 INFO - mozversion == 1.4 12:15:23 INFO - psutil == 3.1.1 12:15:23 INFO - requests == 1.2.3 12:15:23 INFO - wsgiref == 0.1.2 12:15:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100ff0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c70579cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dced30>, '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 0x100cf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dc3be8>, '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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:15:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq4W9Tp634/Render', 12:15:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:23 INFO - 'HOME': '/Users/cltbld', 12:15:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:23 INFO - 'LOGNAME': 'cltbld', 12:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:23 INFO - 'MOZ_NO_REMOTE': '1', 12:15:23 INFO - 'NO_EM_RESTART': '1', 12:15:23 INFO - 'PAGER': '/bin/cat', 12:15:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:23 INFO - 'PWD': '/builds/slave/test', 12:15:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:23 INFO - 'SHELL': '/bin/bash', 12:15:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iwjl1CuJQc/Listeners', 12:15:23 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 12:15:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:23 INFO - 'USER': 'cltbld', 12:15:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:23 INFO - 'XPC_FLAGS': '0x0', 12:15:23 INFO - 'XPC_SERVICE_NAME': '0', 12:15:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:15:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:15:24 INFO - Cleaning up... 12:15:24 INFO - Return code: 0 12:15:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:24 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 0x100ff0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ff3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c70579cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100dced30>, '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 0x100cf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dc3be8>, '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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:15:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq4W9Tp634/Render', 12:15:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:24 INFO - 'HOME': '/Users/cltbld', 12:15:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:24 INFO - 'LOGNAME': 'cltbld', 12:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:24 INFO - 'MOZ_NO_REMOTE': '1', 12:15:24 INFO - 'NO_EM_RESTART': '1', 12:15:24 INFO - 'PAGER': '/bin/cat', 12:15:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:24 INFO - 'PWD': '/builds/slave/test', 12:15:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:24 INFO - 'SHELL': '/bin/bash', 12:15:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iwjl1CuJQc/Listeners', 12:15:24 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 12:15:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:24 INFO - 'USER': 'cltbld', 12:15:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:24 INFO - 'XPC_FLAGS': '0x0', 12:15:24 INFO - 'XPC_SERVICE_NAME': '0', 12:15:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:15:25 INFO - Cleaning up... 12:15:25 INFO - Return code: 0 12:15:25 INFO - Running post-action listener: _resource_record_post_action 12:15:25 INFO - Running post-action listener: _start_resource_monitoring 12:15:25 INFO - Starting resource monitoring. 12:15:25 INFO - [mozharness: 2017-01-12 20:15:25.148938Z] Finished create-virtualenv step (success) 12:15:25 INFO - [mozharness: 2017-01-12 20:15:25.149900Z] Running install step. 12:15:25 INFO - Running pre-action listener: _resource_record_pre_action 12:15:25 INFO - Running main action method: install 12:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:25 INFO - Reading from file tmpfile_stdout 12:15:25 INFO - Detecting whether we're running mozinstall >=1.0... 12:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:15:25 INFO - Reading from file tmpfile_stdout 12:15:25 INFO - Output received: 12:15:25 INFO - Usage: mozinstall [options] installer 12:15:25 INFO - Options: 12:15:25 INFO - -h, --help show this help message and exit 12:15:25 INFO - -d DEST, --destination=DEST 12:15:25 INFO - Directory to install application into. [default: 12:15:25 INFO - "/builds/slave/test"] 12:15:25 INFO - --app=APP Application being installed. [default: firefox] 12:15:25 INFO - mkdir: /builds/slave/test/build/application 12:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:15:47 INFO - Reading from file tmpfile_stdout 12:15:47 INFO - Output received: 12:15:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:15:47 INFO - Running post-action listener: _resource_record_post_action 12:15:47 INFO - [mozharness: 2017-01-12 20:15:47.491704Z] Finished install step (success) 12:15:47 INFO - [mozharness: 2017-01-12 20:15:47.491832Z] Running run-tests step. 12:15:47 INFO - Running pre-action listener: _resource_record_pre_action 12:15:47 INFO - Running main action method: run_tests 12:15:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:15:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:15:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:15:47 INFO - 2017-01-12 12:15:47.506 screenresolution[1629:7341] starting screenresolution argv=screenresolution get 12:15:47 INFO - 2017-01-12 12:15:47.509 screenresolution[1629:7341] Display 0: 1600x1200x32@60 12:15:47 INFO - 2017-01-12 12:15:47.514 screenresolution[1630:7343] starting screenresolution argv=screenresolution list 12:15:47 INFO - Available Modes on Display 0 12:15:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:15:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:15:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:15:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:15:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:15:47 INFO - Intel Iris: 12:15:47 INFO - Chipset Model: Intel Iris 12:15:47 INFO - Type: GPU 12:15:47 INFO - Bus: Built-In 12:15:47 INFO - VRAM (Dynamic, Max): 1536 MB 12:15:47 INFO - Vendor: Intel (0x8086) 12:15:47 INFO - Device ID: 0x0a2e 12:15:47 INFO - Revision ID: 0x0009 12:15:47 INFO - Displays: 12:15:47 INFO - Display: 12:15:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:15:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:15:47 INFO - Display Serial Number: 1600x1200 60 12:15:47 INFO - Main Display: Yes 12:15:47 INFO - Mirror: Off 12:15:47 INFO - Online: Yes 12:15:47 INFO - Rotation: Supported 12:15:47 INFO - Return code: 0 12:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:15:47 INFO - Python 2.7.3 12:15:47 INFO - Return code: 0 12:15:47 INFO - grabbing minidump binary from tooltool 12:15: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')]} 12:15:47 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 0x100dced30>, '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 0x100cf5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100dc3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:15:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:15:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:15:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:15:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:15:47 INFO - Return code: 0 12:15:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:15:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:15:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:15:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:15:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0212 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:15:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq4W9Tp634/Render', 12:15:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:47 INFO - 'HOME': '/Users/cltbld', 12:15:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:47 INFO - 'LOGNAME': 'cltbld', 12:15:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:15:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:47 INFO - 'MOZ_NO_REMOTE': '1', 12:15:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:15:47 INFO - 'NO_EM_RESTART': '1', 12:15:47 INFO - 'PAGER': '/bin/cat', 12:15:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:47 INFO - 'PWD': '/builds/slave/test', 12:15:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:15:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:47 INFO - 'SHELL': '/bin/bash', 12:15:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Iwjl1CuJQc/Listeners', 12:15:47 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 12:15:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:47 INFO - 'USER': 'cltbld', 12:15:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:47 INFO - 'XPC_FLAGS': '0x0', 12:15:47 INFO - 'XPC_SERVICE_NAME': '0', 12:15:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:15:48 INFO - mozversion application_buildid: 20170112105515 12:15:48 INFO - mozversion application_changeset: 6e5f04db4c4a95ad509224b238fd3ad464281e6b 12:15:48 INFO - mozversion application_display_name: Nightly 12:15:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:15:48 INFO - mozversion application_name: Firefox 12:15:48 INFO - mozversion application_remotingname: firefox 12:15:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:15:48 INFO - mozversion application_vendor: Mozilla 12:15:48 INFO - mozversion application_version: 53.0a1 12:15:48 INFO - mozversion platform_buildid: 20170112105515 12:15:48 INFO - mozversion platform_changeset: 6e5f04db4c4a95ad509224b238fd3ad464281e6b 12:15:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:15:48 INFO - mozversion platform_version: 53.0a1 12:15:48 INFO - using testdate: 1484252148 12:15:48 INFO - actual date: 1484252148 12:15:48 INFO - starting webserver on 'localhost:49243' 12:15:48 INFO - SUITE-START | Running 2 tests 12:15:48 INFO - TEST-START | dromaeo_css 12:15:48 INFO - operating with platform_type : mac_ 12:15:48 INFO - Initialising browser for dromaeo_css test... 12:15:48 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp93w63u/profile http://localhost:49243/getInfo.html) 12:15:50 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 12:15:50 INFO - PROCESS | 1640 | colorDepth:24 12:15:50 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 12:15:50 INFO - PROCESS | 1640 | __metrics 12:15:50 INFO - PROCESS | 1640 | 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:15:50 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:15:51 INFO - TEST-INFO | 1640: exit 0 12:15:51 INFO - Browser initialized. 12:15:51 INFO - Running cycle 1/1 for dromaeo_css test... 12:15:51 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp93w63u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:03 INFO - PROCESS | 1642 | RSS: Main: 253329408 12:16:03 INFO - PROCESS | 1642 | 12:19:06 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 12:19:09 INFO - PROCESS | 1642 | RSS: Main: 441438208 12:19:09 INFO - PROCESS | 1642 | 12:20:52 INFO - PROCESS | 1642 | ************************* 12:20:52 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 12:20:52 INFO - PROCESS | 1642 | 12:20:52 INFO - PROCESS | 1642 | Full message: ReferenceError: fetch is not defined 12:20:52 INFO - PROCESS | 1642 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 12:20:52 INFO - PROCESS | 1642 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 12:20:52 INFO - PROCESS | 1642 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 12:20:52 INFO - PROCESS | 1642 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 12:20:52 INFO - PROCESS | 1642 | TaskImpl@resource://gre/modules/Task.jsm:277:3 12:20:52 INFO - PROCESS | 1642 | asyncFunction@resource://gre/modules/Task.jsm:252:14 12:20:52 INFO - PROCESS | 1642 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 12:20:52 INFO - PROCESS | 1642 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 12:20:52 INFO - PROCESS | 1642 | TaskImpl@resource://gre/modules/Task.jsm:277:3 12:20:52 INFO - PROCESS | 1642 | asyncFunction@resource://gre/modules/Task.jsm:252:14 12:20:52 INFO - PROCESS | 1642 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 12:20:52 INFO - PROCESS | 1642 | 12:20:52 INFO - PROCESS | 1642 | ************************* 12:22:12 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 12:22:13 INFO - PROCESS | 1642 | RSS: Main: 384606208 12:22:13 INFO - PROCESS | 1642 | 12:25:15 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 12:25:16 INFO - PROCESS | 1642 | RSS: Main: 358760448 12:25:16 INFO - PROCESS | 1642 | 12:28:18 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 12:28:19 INFO - PROCESS | 1642 | RSS: Main: 362962944 12:28:19 INFO - PROCESS | 1642 | 12:31:23 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 12:31:23 INFO - PROCESS | 1642 | RSS: Main: 335958016 12:31:23 INFO - PROCESS | 1642 | 12:34:27 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 12:34:27 INFO - PROCESS | 1642 | RSS: Main: 404549632 12:34:27 INFO - PROCESS | 1642 | 12:34:27 INFO - PROCESS | 1642 | __start_tp_report 12:34:27 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 12:34:27 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 12:34:27 INFO - PROCESS | 1642 | |i|pagename|runs| 12:34:27 INFO - PROCESS | 1642 | |0;dojo.html;3146.5594816725675;3207.5669784579077;3362.2603027333985;3367;3431.4166591679414;5576.079946808772;5656.802011929583;5694.658320500773;5697.287839020118;5750.511206547438;5653.349864765543;5686.2039314496005;5761.0494268445655;5761.625494342865;5795.420457954203;3629.6733294003534;5135.512126347991;5156.561692256163;5205.869853253661;5282.286891269668;5087.84736457905;5278.049951008817;5289.841304760864;5309.7610607522565;5362.51737343639;5106.693598384071;5269.420363759983;5284.815031473919;5290.92063619046;5319.095753721857;5160.071187186305;5191.2472691459525;5197.584193264567;5217.191335343028;5242.397124330712;5139.203423469368;5174.7412629368755;5196.29849970253;5196.558292545138;5237.004969055867;5731.656100633933;5737.426257374229;5753.309602847643;5753.338366087912;5822;6121.584937613601;6179.412955769195;6196.504279657662;6261.812145635638;6297.118403423525;6268.49852011838;6292.874142517124;6313.810585682437;6338.239411270631;6352.841178970517;5901.996660567671;5904.409559044104;5907;5924.46653432638;5957.404259574095;6244.406781355764;6252.249730032425;6303.810885673437;6307.842303942438;6346.619202847844;6092.908606370908;6111.326590486452;6123.44547193875;6125.235451818339;6130.593106200482;6139.171211886338;6221.782237621662;6267.091271765568;6276.748930042839;6330.841728956813;6096.603720758137;6126.540509461808;6144.938550614526;6153.707721378561;6163.044728067157;5399.352077750695;6069.393060693896;6179.28938172107;6227.906581401283;6274.466670332981;4948;4967.230079337708;4978.6763860348965;4986.700797952134;5009.724465154379;4412.294032954712;4423.977880110579;4463.218936686067;4469.597736203692;4565.246734288805;5057.519535644108;5689.743961521742;5708.086706127;5730.111832665943;5819.53443724501;5995.52035837132;6126.969365153146;6260.285073654789;6317.431431171217;6318.462930650946;5719.828405147852;5748;5750.108733146369;5757.942420575824;5791.82624521265;5349.919751203735;5380.91928621071;5386.542143917733;5403;5443.972780136074;5272.6836389816735;6251;6294.937050629435;6295.559310848288;6323.557350985571;6300.810975670737;6306.842328941813;6318.62088274705;6336.144620476177;6342.270638876588;5336;6335.524835637253;6341.90487142684;6350.555461117678;6357.046443033582;6081.179040829608;6104.084387341934;6250.593711408744;6260.436560709558;6275.560710750204;6232.626042437469;6241;6282.937170628235;6337.4613157882095;6347.238331400262;4758.286257061469;5985;6130.080487926846;6159.876802463836;6162.630242185483;5964.493018093337;6186.041163619646;6191.721372538336;6212.161358216583;6217;5840.853978650568;5883.55873309512;5974.074018527135;6000.189974353407;6039.214902062704;6063.363346848518;6069.4840938518955;6104.0347610180015;6107.310189946561;6127.769884593477;5931.377205393372;5982.46157845796;6001.729922153426;6004.729787159676;6012.6993650316435 12:34:27 INFO - PROCESS | 1642 | |1;ext.html;483.3305871368154;488.45049319515545;501.7416030744166;508.8117396563271;518.9429162792093;24603.384915377126;38788.22423551531;40567.59432405679;40676.779696609075;42974.14051718964;35342.2931541369;43438.91402714934;43444;43553;43636.56363436364;9016.188543031127;9231.353805233637;9235.12266334697;9244.214241789456;9254.398464099811;8345.54099524526;8565.828683426327;11013.724656883602;11242.381669008202;11255.380954047525;11191.496382662799;11207.66377008691;11217.439128043607;11281.37952412617;11288.322700637988;8380.83238335236;11204.383758893258;11231.438428078603;11242.775144497064;11287.209895307331;8381.832363352698;10834.67495975122;11055.336679799238;11069.667909962714;11275.943620281929;40181.19637607261;40467.7976610118;40578;40629.796851015555;40655.1868962622;3988.980055099706;4004.8798536043964;4014.6186112319283;4029.625226028579;4061.6547593454297;30120;30380;30451.543226851616;30992.225194370094;31370;2975.61317028787;3175.4760464523556;3192.377486390155;3283.688049635281;3328.251143492719;406190;445490;449702;450594;452698;61382.38617613856;62483.68758156271;62653;62999;63042.68478657577;65512;65603;65618.67190664016;65663.67168164224;65723.01415478771;15067.397304107932;15676;16159.192040397933;16215.513534593982;16219.107949062678;11147.777044459066;11383.487743051583;12118.757624847454;12182.939085304517;12212.267263964191;14522.636934076732;15617.453389131326;16239.756403653955;16676.416325428552;17498.825011749974;6622.205335359788;6640.734370625121;6647.534672572873;6675.899861502081;6711;883.3198437203317;886.1448702002598;904.8235594059227;914.6341463414554;930.9441433514011;29915.117460696838;30074.248143796143;30243.69756302453;30566.84716576403;30828;1071.6517131932153;1074.1084899533369;1109.1071687291646;1116.3580940958818;1225.24789550943;13313.600591982256;15413.537593871977;15683.921580392025;15716.764248536281;16115.355385784438;558986;568254;570333;570506;571468;60838;60915.695421523495;61064.694676526335;61119.69440152771;61231.77536449246;1291.1155858237137;1421.3390773290469;1434.7704367301183;1462.3200211901517;1471.4849802569015;24553.772311384717;24688.753112469363;28879.85560072186;29472.7895407841;30301.393972120874;51651;52047.73976130095;52126.47873521368;52161.47838521566;52267.73866130645;481438;482460;482830;482896;482914;19770.90114549418;24496.38759030967;24699.753002469744;40437.95620437933;40823.79588102041;41216.79391603023;41280;41666.79166604148;41845.37231941462;43063.35404968991;35534.289314213056;35625.643743562236;36328;37008.629913701596;37022;34774.82612586921;35420;36067.819660902576;36081.097972550895;36362.63637363593;33711.15722106967;34176.82911585426;34830.30339393249;34832;34875.4768678465;30830.229244269074;31564.210894726897;31786.682133179296;31882.52176217312;31908.6809131915;22402.103915843185;23137.60909376689;23300;23327.883360583088;23435.41411464727 12:34:27 INFO - PROCESS | 1642 | |2;jquery.html;364.7209884438403;385.59705108161967;387.59496326338973;392.70154682441347;419.2851188723227;15231;15310.311036003379;18146.455606331798;20555.794442055576;20667;19156.233750649957;21119.260825871097;21186.046627901742;21716.782832171673;21752.238671646497;5202.245674377223;5294.973525132388;5367.677939323634;5372.086745253297;5913.14259432382;3203.4073696366245;5797.275340582427;5897.793577224798;5899.056151015839;5900.055991041413;4031.23406552754;4085.142120154771;4087.2847251730977;4087.652549533293;4092.7953602319913;4039.9798001009954;6548.377904099079;6602.93397066028;6603.273639899608;6634.336566343375;5643.887122257573;5698.173764804122;5768;5868.09044598088;5889.322727886305;13356.332183390792;13439.395227214702;13494.86505134946;13508.932455337661;13557.661058473519;2576.2400091972913;2601.4666993266337;2644.2067379785985;2725.2505560970694;2742.3966727319957;10292.588296468133;10317.329373590692;10322.638707645196;10855.620053298175;11988.70028249292;1866.6546688862604;1881.3039175505014;1881.8212269834344;1906.809319068082;1941.213808407597;131889;141010;142023;144084;144545.27727361402;11391.316521008766;11684;11855.822162667568;11892.565278054682;11920.344381058952;15804.525864224091;15807.68384632324;15852.207389630472;15889.841101588836;15893.523194304189;8428.704995325133;8601.354898382646;8675.305975521944;8712.651493940171;8723.171298726611;8218.137095604876;8229.46508476947;8269;8412.625434773883;8419.789505262417;4681.555252251031;4759.714417134983;4763.309320148559;4780.139574876486;4862.440819305754;1951.9024048797787;2008.2067583304513;2010.256205204084;2012.1488230827674;2013.365789776245;860.3160487412522;880.7665968518347;882.8787439951226;893.1782759860944;919.4621146629297;18777.436676899713;20666.483337916674;21854.934720125824;24060.759392406202;24224.75775242225;925.4817302310728;998.7553049502918;1045.1220974381556;1057.2916146182076;1079.6005477973042;9907.207423406111;10801.891981080245;11210.977973655614;11216.522877907875;11274.605388811353;595326;723831;724048.5570865765;738772.3061384659;740325;106580.9341906571;109412;139191;139748;145518.27240863728;1094.3269889018197;1110.6223883879682;1140.1107136433595;1140.4810811080938;1146.415328182633;15562.610934726723;16707.24817383245;18579.721304180177;18698.43904682862;19595.902020489808;51828.74085629548;55198.44801551933;55534;55949;56034.15948760854;75911.24088759262;76275.61862190654;77283.61358193398;77687.61156194408;77887.83168252594;7474.364679002346;8143.104258531438;8144.877826832484;8381.580920953806;8627.741167764978;8086.1913808618665;11974.760504789681;12887.09790314669;13281.66795830112;13438.731225375634;10861.239713219999;11266.774664506827;11472.369019703663;11519.481623327138;11602.825957610812;10998.780024399308;11145.83281250798;11382.37396943143;11466.069237533015;11613.6515904523;11198.888011119785;11245.775084498428;11452.885471145182;11678.766424671288;11746.823797643214;6861.485388595976;8233.629486673233;8281.254687078192;8378.916210837813;8425.452345597516;7632.3512501438;10780.784384312426;11193.552257909592;11342.149338799789;11399.715007124889 12:34:27 INFO - PROCESS | 1642 | |3;mootools.html;1345.0920628575711;1440.9279536023203;1460.2260801775062;1465.721512912546;1471.382019551788;8099.4330396872165;8469.95765021174;8498.022727386353;8515.276201522878;8524.659013639446;7423;7699.345555627779;7715.267049630276;8156.469829461095;8386.832263354729;2294.128231272114;2321.1063740459876;2328.2200462844967;2334.743178250391;2339.532093581282;2291.702078729763;2328.3364241191266;2333.8132949364094;2342.367560758594;2342.5080733045997;2004.7995200479982;2080.3238947342097;2252.8986195621237;2302.7121609798774;2326.6975293211945;2257.661350797377;2259.062489067035;2261.8416710830247;2267.5238199978025;2272.7727227277305;2253.1438053539714;2303.309007297804;2341.3210169050953;2348.659444380555;2348.823838212141;8448;8513.659453621847;8522.914770852274;8525.488470691778;8525.786855328604;5063.063333283318;5219.582433405319;5220.295260139908;5223.608229382811;5228.712420816853;3305.9504107438406;3463.5497385339745;3489.94765078524;3556.217632120955;3563.1448452371505;969.2536746704998;1200.8203624258185;1202.9518819247219;1251.1429670675616;1252.9812052819216;10792.946035269773;10903.563857445693;10951;10969;10987.670369888996;4462.888427789267;4599.885002874955;4680.695754775928;4685.929711054337;4695.154872122982;9612.615495380247;9626.229901607854;9626.855597166048;9627;9642.276829237835;5274.7098909560345;5276.34045744282;5277.287566178594;5281.39263984639;5301.1783173608155;4059.715819892638;4283.614474697292;4353.190076748121;4757.238841785367;4796.736179510091;3794.9241015180096;3844.3464611016193;3896.629820167136;3934.901627459279;3938.448617193595;1071.3678929431674;1278.9360531973364;1280.6734282758023;1286.8777466140702;1298.2794549025382;861.3496809908604;898.9415687980392;911.5533388639651;917.8118485710413;938.9765255868658;4428.623566996777;5525.518923078434;5657.858553536113;5683.516901063456;5765.221695071112;561.7668667502941;574.3653263144249;574.4284436985226;574.4973148495067;585.2012003615035;3680.411134218512;3759.755615884959;3797.696184305304;3803;3835.4246862970776;9446.574904129331;9916;9988.400695958266;10127.64553240633;10166;9852.16256618181;9943.005699430143;10070.496475176213;10074.546645400975;10096.14182794456;7608.391328693691;7799.259070388304;7814.3748500119855;7925.841483170304;7947.721829735931;5446.700431476148;5468.808591699271;5470.015397228537;5517.475839795213;5552.7223638818705;7759.883601746092;7979.48133371329;9064.546772661472;9145.817083658423;9478.004809494903;8104.27061564462;8432.988041435066;8926.910730892867;9073.727788166365;9576.616935322509;6006.759729610767;6615.206175258807;6857.108575885302;6864.828379290558;7290.927090729237;7660.923390766021;7964.482308649919;7984.441089123706;8077.27304542594;8115.391345648982;6897.965510172417;7071.611061391673;7215.989761433299;7311.049563556704;7338.339549440576;6930.861382772216;7024.402925751164;7063.611501367269;7136.036635054201;7156.248593897566;5367.946320536901;6269.31037585856;6409.903851442139;6482.773102941374;6498.090267362668;4965.354503914468;5000.449950505515;5016.648834581544;5069.619778516552;5110.795568177231;4722.480527141943;4778.307145463818;4885.438174609965;5020.949790502048;5027.673201241908 12:34:27 INFO - PROCESS | 1642 | |4;prototype.html;310.5822668510853;341.8235799671851;360.2830367568538;367.8418280139542;368.76583369560336;5152.742362881855;5236.84289471316;5292.603054770893;5340.264414065435;5354.705491197982;4212.726172798766;4536.27419612862;5244.737763111848;5286.704757334449;5303.401333346661;3397.4032204863674;3483.599386070596;4032.9798351008203;4079.5522686388153;4089.7137200395982;3478.339115568034;3676.411774116142;3767.9058023549355;3986.6611338036155;4029.7179197456044;3962.8600555699886;3967.2065586882595;3971.299516328895;3974.6224108709625;3985.8007099645047;3181.3319202967405;3237.4981877808978;3599.136207310227;3927.705422093326;3951.901202469947;2923.2606599073515;3052.0628389377675;3092.912284208173;3112.6576076631554;3191.250056236806;4475.977620111911;5134.358205224347;5135.64050516464;5137.717425541631;5172.517191747945;4198.349255865346;4561.817527298904;4572.736495434748;4576.748278844662;4581.79381927814;5242;5531.612787104904;5599.384067752544;5606.943930560683;5638.577106716972;3527.682508574215;3829.5596006459054;3833.5016447861876;3851.4415409765706;3858.4405261237243;5458.781648734085;5889.027175896037;5913.121674618457;5913.763449461973;5926.377730338339;3225.9677403226137;3229.9192520187185;3567.8216089195435;3841.5774264830848;3879.4568760373572;3951.209758048344;3951.9012024699614;3954.6045395460224;3966.1671049080014;3972.3842804365368;4561.338605902126;4561.657875659339;4576.199165146086;4589.862304130881;4614.031053478807;5463.606780271085;5552.880126585982;5576.247206627135;5641.984442800335;5678.545716342683;1171.8710941796396;1193.76721539299;1264.867943190839;1273.4269578689627;1273.7452509498137;729.3727394440776;850.3248600257606;852.1691350932791;864.4078806017898;867.4361664917727;4880.731559764247;4895.111883988464;4954.281629163823;5044.016416798689;5069.695818250843;4699.694519856198;5192.015664961679;5416.641682157009;5714.371419143891;5738.311402631627;5136.332276803992;5154.896902061938;5160.148575485078;5164.870878228075;5175.404828444702;2408.0969636386353;2554.0805310088354;2594.6648016785043;2799.636047313836;2853.4007858349564;5126.4620613815705;5289.788408463695;5688.431156884361;5693.743781529841;5709.200711900337;4683.531646835289;4866.926996095061;5377.462253774669;5464;5634.971825140848;4904.2589880593305;5232.9738351308;5644.435556444323;5707.514861236758;5737.483626473638;4842.346283251857;5042.058807359266;5269.420363759907;5482.1624862595545;5498.945010549844;4665.320484625464;5029.874253143701;5159.767810448614;5289.100852854947;5340.465953404629;5120.107139466189;5125.513076257749;5323.1216849219445;5696.259486266758;5738.192469372135;3311.7019468247972;3458.996890901711;3712.934336901089;3962.3065963456856;3976.661983731415;4731.479537250969;4892.510748925079;5253.660316619391;5291.894162116813;5465.6447330923365;5073.231162707044;5199.220116982483;5248.168836749118;5314.721649072534;5318.8936221276135;4491.865244042684;5181.663191892515;5233.760653870378;5260.789568417221;5323.494268044529;4351.717138385995;4618.330342100444;4705.882352941258;4988.825391111293;5177.427574973256;4358.978205108954;5000.724091265584;5269.257668098742;5337.599680023936;5353.143497040455;4389.780510974502;4786.617070634411;4863.975680121577;5483.8080667176455;5514.91727624078 12:34:27 INFO - PROCESS | 1642 | |5;yui.html;694.8158737934451;706.9007693037331;765.7396485195032;813.3940214540169;819.5410570080753;14722.411103555858;15691.60770980726;15985.040897546127;16090.356385744572;16257.75613365799;14281.07173033752;14605.415783368653;14820.777688334683;14847.554573362817;14851.257437128128;857.3141486810558;872.0799556467924;876.9824603507926;877.5085951866943;877.868319752036;652.9510286728514;698.5773606967788;716.7204790131852;720.3840716187663;873.7335112790596;918.6509126531909;930.6463543853326;933.2953620016912;935.1536859142487;936.5410948635154;926.1942110363959;926.5135803703042;926.5969303353063;927.554773708617;927.7958849053198;534.3907944942769;550.9256250406224;663.4659099424961;690.4648897104734;691.5470366909682;15110.093394396372;15544.844551554454;15757.763633545506;15766.369345226178;15778.842211577852;14015.929920350434;14135.293235338191;14187.148771073666;14199.36102875373;14292.642683932881;12875.67810804728;12956;13016.804747928789;13048.412821423059;13366.198028118344;3492.807895565743;3851.5185601799776;4616.238320677085;4667.95332046682;4692.366530518405;101639.98360016453;102029;104393.95606043919;106322;107946.0629665368;10868.076213521781;10889.782204355868;10978.725531861608;11000.449977501094;11228.045616122721;19818;21321.573568528544;21329.46676333073;21345.78654213438;21359;6462.903056454157;7413.258674132544;7509.586972716553;7579.583122928292;7647.349975252166;4149.170165966819;4205.137946720914;4231.703780735381;4324.13517296542;4329.350597410414;3365.2764655599162;3397.252604427022;3434.7252219822353;3440.3119376124873;3467.7745946513396;630.1146888621494;632.3107812484415;638.2978723404311;656.4551422319463;656.8390744267685;559.3846768554639;639.7269433826651;644.5455953552735;652.8270008447765;664.4651055900047;8121.593920303962;8374.958125209336;9136.451812891248;9531.618735250513;9876.35803672759;614.7049416280121;637.416763661254;644.1593720195096;648.2480322825594;669.4769399615913;4441.489228738672;4716.481187069419;4724.267738500538;4727.196376615983;4749.786259618326;100881;103600.05786430808;106426.93573064171;107703.46148269209;107961.92038079676;73974.26025739781;74630.25369746341;75519.62240188874;92543.53728231316;94059;81465.59267203626;83680.58159709163;83769.58115209384;83814.58092709619;85509.71735423974;9043.457392556467;9265.53672316368;9289.914562312513;9385.296102792181;9392.530373481162;52656.21015684844;53186;55378;55636.57991673154;55675.72162139163;60373.79252415015;72381.6380918092;73542.63228684037;73684.26315736774;74097;10830.67507974762;10888.836667449836;10926.344419334866;11162;11164.274322169033;11539.911506180559;11560.768784624428;11598.94200528992;11872.584459543874;12061.577844775391;11262.662120136409;11797.941010294893;11831.230969986924;11851.051915846883;12270.877291226974;9757.31698781107;11077.279976801483;11602.767944640891;12140.028797695986;12184.878151218729;11431.771364572829;11548.0761539075;11856.644300670994;11881.22772019816;11919;9502.334836561651;9502.952485237529;9571.569279382305;10057.647982320876;10059.547320370455;7973.978807894086;9290.674826381044;9372.95313523428;9373.625054997723;9472.905270947202 12:34:27 INFO - PROCESS | 1642 | __end_tp_report 12:34:27 INFO - PROCESS | 1642 | __start_cc_report 12:34:27 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,2394 12:34:27 INFO - PROCESS | 1642 | __end_cc_report 12:34:27 INFO - PROCESS | 1642 | __startTimestamp1484253267547__endTimestamp 12:34:27 INFO - PROCESS | 1642 | 12:34:27 INFO - PROCESS | 1642 | ------- Summary: start ------- 12:34:27 INFO - PROCESS | 1642 | Number of tests: 6 12:34:27 INFO - PROCESS | 1642 | 12:34:27 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5726.67 Median:5964.49 stddev:668.21 (11.2%) stddev-sans-first:638.87 12:34:27 INFO - PROCESS | 1642 | Values: 3146.6 3207.6 3362.3 3367.0 3431.4 5576.1 5656.8 5694.7 5697.3 5750.5 5653.3 5686.2 5761.0 5761.6 5795.4 3629.7 5135.5 5156.6 5205.9 5282.3 5087.8 5278.0 5289.8 5309.8 5362.5 5106.7 5269.4 5284.8 5290.9 5319.1 5160.1 5191.2 5197.6 5217.2 5242.4 5139.2 5174.7 5196.3 5196.6 5237.0 5731.7 5737.4 5753.3 5753.3 5822.0 6121.6 6179.4 6196.5 6261.8 6297.1 6268.5 6292.9 6313.8 6338.2 6352.8 5902.0 5904.4 5907.0 5924.5 5957.4 6244.4 6252.2 6303.8 6307.8 6346.6 6092.9 6111.3 6123.4 6125.2 6130.6 6139.2 6221.8 6267.1 6276.7 6330.8 6096.6 6126.5 6144.9 6153.7 6163.0 5399.4 6069.4 6179.3 6227.9 6274.5 4948.0 4967.2 4978.7 4986.7 5009.7 4412.3 4424.0 4463.2 4469.6 4565.2 5057.5 5689.7 5708.1 5730.1 5819.5 5995.5 6127.0 6260.3 6317.4 6318.5 5719.8 5748.0 5750.1 5757.9 5791.8 5349.9 5380.9 5386.5 5403.0 5444.0 5272.7 6251.0 6294.9 6295.6 6323.6 6300.8 6306.8 6318.6 6336.1 6342.3 5336.0 6335.5 6341.9 6350.6 6357.0 6081.2 6104.1 6250.6 6260.4 6275.6 6232.6 6241.0 6282.9 6337.5 6347.2 4758.3 5985.0 6130.1 6159.9 6162.6 5964.5 6186.0 6191.7 6212.2 6217.0 5840.9 5883.6 5974.1 6000.2 6039.2 6063.4 6069.5 6104.0 6107.3 6127.8 5931.4 5982.5 6001.7 6004.7 6012.7 12:34:27 INFO - PROCESS | 1642 | 12:34:27 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:63964.18 Median:36074.46 stddev:133127.27 (369.0%) stddev-sans-first:133415.41 12:34:27 INFO - PROCESS | 1642 | Values: 483.3 488.5 501.7 508.8 518.9 24603.4 38788.2 40567.6 40676.8 42974.1 35342.3 43438.9 43444.0 43553.0 43636.6 9016.2 9231.4 9235.1 9244.2 9254.4 8345.5 8565.8 11013.7 11242.4 11255.4 11191.5 11207.7 11217.4 11281.4 11288.3 8380.8 11204.4 11231.4 11242.8 11287.2 8381.8 10834.7 11055.3 11069.7 11275.9 40181.2 40467.8 40578.0 40629.8 40655.2 3989.0 4004.9 4014.6 4029.6 4061.7 30120.0 30380.0 30451.5 30992.2 31370.0 2975.6 3175.5 3192.4 3283.7 3328.3 406190.0 445490.0 449702.0 450594.0 452698.0 61382.4 62483.7 62653.0 62999.0 63042.7 65512.0 65603.0 65618.7 65663.7 65723.0 15067.4 15676.0 16159.2 16215.5 16219.1 11147.8 11383.5 12118.8 12182.9 12212.3 14522.6 15617.5 16239.8 16676.4 17498.8 6622.2 6640.7 6647.5 6675.9 6711.0 883.3 886.1 904.8 914.6 930.9 29915.1 30074.2 30243.7 30566.8 30828.0 1071.7 1074.1 1109.1 1116.4 1225.2 13313.6 15413.5 15683.9 15716.8 16115.4 558986.0 568254.0 570333.0 570506.0 571468.0 60838.0 60915.7 61064.7 61119.7 61231.8 1291.1 1421.3 1434.8 1462.3 1471.5 24553.8 24688.8 28879.9 29472.8 30301.4 51651.0 52047.7 52126.5 52161.5 52267.7 481438.0 482460.0 482830.0 482896.0 482914.0 19770.9 24496.4 24699.8 40438.0 40823.8 41216.8 41280.0 41666.8 41845.4 43063.4 35534.3 35625.6 36328.0 37008.6 37022.0 34774.8 35420.0 36067.8 36081.1 36362.6 33711.2 34176.8 34830.3 34832.0 34875.5 30830.2 31564.2 31786.7 31882.5 31908.7 22402.1 23137.6 23300.0 23327.9 23435.4 12:34:27 INFO - PROCESS | 1642 | 12:34:27 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:38269.87 Median:21734.51 stddev:117647.72 (541.3%) stddev-sans-first:117943.33 12:34:27 INFO - PROCESS | 1642 | Values: 364.7 385.6 387.6 392.7 419.3 15231.0 15310.3 18146.5 20555.8 20667.0 19156.2 21119.3 21186.0 21716.8 21752.2 5202.2 5295.0 5367.7 5372.1 5913.1 3203.4 5797.3 5897.8 5899.1 5900.1 4031.2 4085.1 4087.3 4087.7 4092.8 4040.0 6548.4 6602.9 6603.3 6634.3 5643.9 5698.2 5768.0 5868.1 5889.3 13356.3 13439.4 13494.9 13508.9 13557.7 2576.2 2601.5 2644.2 2725.3 2742.4 10292.6 10317.3 10322.6 10855.6 11988.7 1866.7 1881.3 1881.8 1906.8 1941.2 131889.0 141010.0 142023.0 144084.0 144545.3 11391.3 11684.0 11855.8 11892.6 11920.3 15804.5 15807.7 15852.2 15889.8 15893.5 8428.7 8601.4 8675.3 8712.7 8723.2 8218.1 8229.5 8269.0 8412.6 8419.8 4681.6 4759.7 4763.3 4780.1 4862.4 1951.9 2008.2 2010.3 2012.1 2013.4 860.3 880.8 882.9 893.2 919.5 18777.4 20666.5 21854.9 24060.8 24224.8 925.5 998.8 1045.1 1057.3 1079.6 9907.2 10801.9 11211.0 11216.5 11274.6 595326.0 723831.0 724048.6 738772.3 740325.0 106580.9 109412.0 139191.0 139748.0 145518.3 1094.3 1110.6 1140.1 1140.5 1146.4 15562.6 16707.2 18579.7 18698.4 19595.9 51828.7 55198.4 55534.0 55949.0 56034.2 75911.2 76275.6 77283.6 77687.6 77887.8 7474.4 8143.1 8144.9 8381.6 8627.7 8086.2 11974.8 12887.1 13281.7 13438.7 10861.2 11266.8 11472.4 11519.5 11602.8 10998.8 11145.8 11382.4 11466.1 11613.7 11198.9 11245.8 11452.9 11678.8 11746.8 6861.5 8233.6 8281.3 8378.9 8425.5 7632.4 10780.8 11193.6 11342.1 11399.7 12:34:27 INFO - PROCESS | 1642 | 12:34:27 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5389.04 Median:5275.53 stddev:2959.05 (56.1%) stddev-sans-first:2951.75 12:34:27 INFO - PROCESS | 1642 | Values: 1345.1 1440.9 1460.2 1465.7 1471.4 8099.4 8470.0 8498.0 8515.3 8524.7 7423.0 7699.3 7715.3 8156.5 8386.8 2294.1 2321.1 2328.2 2334.7 2339.5 2291.7 2328.3 2333.8 2342.4 2342.5 2004.8 2080.3 2252.9 2302.7 2326.7 2257.7 2259.1 2261.8 2267.5 2272.8 2253.1 2303.3 2341.3 2348.7 2348.8 8448.0 8513.7 8522.9 8525.5 8525.8 5063.1 5219.6 5220.3 5223.6 5228.7 3306.0 3463.5 3489.9 3556.2 3563.1 969.3 1200.8 1203.0 1251.1 1253.0 10792.9 10903.6 10951.0 10969.0 10987.7 4462.9 4599.9 4680.7 4685.9 4695.2 9612.6 9626.2 9626.9 9627.0 9642.3 5274.7 5276.3 5277.3 5281.4 5301.2 4059.7 4283.6 4353.2 4757.2 4796.7 3794.9 3844.3 3896.6 3934.9 3938.4 1071.4 1278.9 1280.7 1286.9 1298.3 861.3 898.9 911.6 917.8 939.0 4428.6 5525.5 5657.9 5683.5 5765.2 561.8 574.4 574.4 574.5 585.2 3680.4 3759.8 3797.7 3803.0 3835.4 9446.6 9916.0 9988.4 10127.6 10166.0 9852.2 9943.0 10070.5 10074.5 10096.1 7608.4 7799.3 7814.4 7925.8 7947.7 5446.7 5468.8 5470.0 5517.5 5552.7 7759.9 7979.5 9064.5 9145.8 9478.0 8104.3 8433.0 8926.9 9073.7 9576.6 6006.8 6615.2 6857.1 6864.8 7290.9 7660.9 7964.5 7984.4 8077.3 8115.4 6898.0 7071.6 7216.0 7311.0 7338.3 6930.9 7024.4 7063.6 7136.0 7156.2 5367.9 6269.3 6409.9 6482.8 6498.1 4965.4 5000.4 5016.6 5069.6 5110.8 4722.5 4778.3 4885.4 5020.9 5027.7 12:34:27 INFO - PROCESS | 1642 | 12:34:27 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4364.59 Median:4929.27 stddev:1348.44 (27.4%) stddev-sans-first:1317.44 12:34:27 INFO - PROCESS | 1642 | Values: 310.6 341.8 360.3 367.8 368.8 5152.7 5236.8 5292.6 5340.3 5354.7 4212.7 4536.3 5244.7 5286.7 5303.4 3397.4 3483.6 4033.0 4079.6 4089.7 3478.3 3676.4 3767.9 3986.7 4029.7 3962.9 3967.2 3971.3 3974.6 3985.8 3181.3 3237.5 3599.1 3927.7 3951.9 2923.3 3052.1 3092.9 3112.7 3191.3 4476.0 5134.4 5135.6 5137.7 5172.5 4198.3 4561.8 4572.7 4576.7 4581.8 5242.0 5531.6 5599.4 5606.9 5638.6 3527.7 3829.6 3833.5 3851.4 3858.4 5458.8 5889.0 5913.1 5913.8 5926.4 3226.0 3229.9 3567.8 3841.6 3879.5 3951.2 3951.9 3954.6 3966.2 3972.4 4561.3 4561.7 4576.2 4589.9 4614.0 5463.6 5552.9 5576.2 5642.0 5678.5 1171.9 1193.8 1264.9 1273.4 1273.7 729.4 850.3 852.2 864.4 867.4 4880.7 4895.1 4954.3 5044.0 5069.7 4699.7 5192.0 5416.6 5714.4 5738.3 5136.3 5154.9 5160.1 5164.9 5175.4 2408.1 2554.1 2594.7 2799.6 2853.4 5126.5 5289.8 5688.4 5693.7 5709.2 4683.5 4866.9 5377.5 5464.0 5635.0 4904.3 5233.0 5644.4 5707.5 5737.5 4842.3 5042.1 5269.4 5482.2 5498.9 4665.3 5029.9 5159.8 5289.1 5340.5 5120.1 5125.5 5323.1 5696.3 5738.2 3311.7 3459.0 3712.9 3962.3 3976.7 4731.5 4892.5 5253.7 5291.9 5465.6 5073.2 5199.2 5248.2 5314.7 5318.9 4491.9 5181.7 5233.8 5260.8 5323.5 4351.7 4618.3 4705.9 4988.8 5177.4 4359.0 5000.7 5269.3 5337.6 5353.1 4389.8 4786.6 4864.0 5483.8 5514.9 12:34:27 INFO - PROCESS | 1642 | 12:34:27 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20321.73 Median:28703.00 stddev:29793.20 (103.8%) stddev-sans-first:29840.32 12:34:27 INFO - PROCESS | 1642 | Values: 694.8 706.9 765.7 813.4 819.5 14722.4 15691.6 15985.0 16090.4 16257.8 14281.1 14605.4 14820.8 14847.6 14851.3 857.3 872.1 877.0 877.5 877.9 653.0 698.6 716.7 720.4 873.7 918.7 930.6 933.3 935.2 936.5 926.2 926.5 926.6 927.6 927.8 534.4 550.9 663.5 690.5 691.5 15110.1 15544.8 15757.8 15766.4 15778.8 14015.9 14135.3 14187.1 14199.4 14292.6 12875.7 12956.0 13016.8 13048.4 13366.2 3492.8 3851.5 4616.2 4668.0 4692.4 101640.0 102029.0 104394.0 106322.0 107946.1 10868.1 10889.8 10978.7 11000.4 11228.0 19818.0 21321.6 21329.5 21345.8 21359.0 6462.9 7413.3 7509.6 7579.6 7647.3 4149.2 4205.1 4231.7 4324.1 4329.4 3365.3 3397.3 3434.7 3440.3 3467.8 630.1 632.3 638.3 656.5 656.8 559.4 639.7 644.5 652.8 664.5 8121.6 8375.0 9136.5 9531.6 9876.4 614.7 637.4 644.2 648.2 669.5 4441.5 4716.5 4724.3 4727.2 4749.8 100881.0 103600.1 106426.9 107703.5 107961.9 73974.3 74630.3 75519.6 92543.5 94059.0 81465.6 83680.6 83769.6 83814.6 85509.7 9043.5 9265.5 9289.9 9385.3 9392.5 52656.2 53186.0 55378.0 55636.6 55675.7 60373.8 72381.6 73542.6 73684.3 74097.0 10830.7 10888.8 10926.3 11162.0 11164.3 11539.9 11560.8 11598.9 11872.6 12061.6 11262.7 11797.9 11831.2 11851.1 12270.9 9757.3 11077.3 11602.8 12140.0 12184.9 11431.8 11548.1 11856.6 11881.2 11919.0 9502.3 9503.0 9571.6 10057.6 10059.5 7974.0 9290.7 9373.0 9373.6 9472.9 12:34:27 INFO - PROCESS | 1642 | -------- Summary: end -------- 12:34:27 INFO - PROCESS | 1642 | 12:34:28 INFO - TEST-INFO | 1642: exit 0 12:34:28 INFO - TEST-OK | dromaeo_css | took 1120117ms 12:34:28 INFO - TEST-START | kraken 12:34:28 INFO - operating with platform_type : mac_ 12:34:28 INFO - Initialising browser for kraken test... 12:34:28 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpwetoa5/profile http://localhost:49243/getInfo.html) 12:34:30 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 12:34:30 INFO - PROCESS | 1653 | colorDepth:24 12:34:30 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 12:34:30 INFO - PROCESS | 1653 | __metrics 12:34:30 INFO - PROCESS | 1653 | 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:34:30 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:34:31 INFO - TEST-INFO | 1653: exit 0 12:34:31 INFO - Browser initialized. 12:34:31 INFO - Running cycle 1/1 for kraken test... 12:34:31 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpwetoa5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:34:43 INFO - PROCESS | 1654 | RSS: Main: 245911552 12:34:43 INFO - PROCESS | 1654 | 12:34:46 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 12:34:47 INFO - PROCESS | 1654 | RSS: Main: 303747072 12:34:47 INFO - PROCESS | 1654 | 12:34:49 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 12:34:50 INFO - PROCESS | 1654 | RSS: Main: 305704960 12:34:50 INFO - PROCESS | 1654 | 12:34:53 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 12:34:54 INFO - PROCESS | 1654 | RSS: Main: 394932224 12:34:54 INFO - PROCESS | 1654 | 12:34:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 12:34:57 INFO - PROCESS | 1654 | RSS: Main: 296890368 12:34:57 INFO - PROCESS | 1654 | 12:34:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:34:59 INFO - PROCESS | 1654 | RSS: Main: 300449792 12:34:59 INFO - PROCESS | 1654 | 12:35:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:03 INFO - PROCESS | 1654 | RSS: Main: 342777856 12:35:03 INFO - PROCESS | 1654 | 12:35:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 12:35:06 INFO - PROCESS | 1654 | RSS: Main: 343236608 12:35:06 INFO - PROCESS | 1654 | 12:35:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 12:35:10 INFO - PROCESS | 1654 | RSS: Main: 342392832 12:35:10 INFO - PROCESS | 1654 | 12:35:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:35:12 INFO - PROCESS | 1654 | RSS: Main: 317472768 12:35:12 INFO - PROCESS | 1654 | 12:35:14 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:35:15 INFO - PROCESS | 1654 | RSS: Main: 321597440 12:35:15 INFO - PROCESS | 1654 | 12:35:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:35:18 INFO - PROCESS | 1654 | RSS: Main: 323543040 12:35:18 INFO - PROCESS | 1654 | 12:35:21 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:35:21 INFO - PROCESS | 1654 | RSS: Main: 340189184 12:35:21 INFO - PROCESS | 1654 | 12:35:24 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:35:25 INFO - PROCESS | 1654 | RSS: Main: 334110720 12:35:25 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 12:35:27 INFO - PROCESS | 1654 | RSS: Main: 378212352 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | __start_tp_report 12:35:27 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 12:35:27 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 12:35:27 INFO - PROCESS | 1654 | |i|pagename|runs| 12:35:27 INFO - PROCESS | 1654 | |0;ai-astar;111;114;114;115;113;114;114;121;156;114 12:35:27 INFO - PROCESS | 1654 | |1;audio-beat-detection;147;112;112;150;114;110;111;112;138;100 12:35:27 INFO - PROCESS | 1654 | |2;audio-dft;183;185;185;185;184;185;184;181;185;183 12:35:27 INFO - PROCESS | 1654 | |3;audio-fft;79;59;59;87;60;66;49;66;88;82 12:35:27 INFO - PROCESS | 1654 | |4;audio-oscillator;90;71;85;69;68;69;84;69;67;82 12:35:27 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;87;85;89;86;88;84;87;85;87;84 12:35:27 INFO - PROCESS | 1654 | |6;imaging-darkroom;127;151;94;94;93;94;94;94;92;93 12:35:27 INFO - PROCESS | 1654 | |7;imaging-desaturate;129;132;133;87;86;85;87;84;86;86 12:35:27 INFO - PROCESS | 1654 | |8;json-parse-financial;45;56;52;53;54;55;56;54;54;55 12:35:27 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;67;68;77;75;72;70;71;70;70;71 12:35:27 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;86;86;85;87;90;90;96;108;108;102 12:35:27 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;141;141;140;143;142;141;141;138;179;142 12:35:27 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;180;179;176;176;172;176;177;175;177;175 12:35:27 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;68;68;70;67;69;68;68;68;66;68 12:35:27 INFO - PROCESS | 1654 | __end_tp_report 12:35:27 INFO - PROCESS | 1654 | __start_cc_report 12:35:27 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2002 12:35:27 INFO - PROCESS | 1654 | __end_cc_report 12:35:27 INFO - PROCESS | 1654 | __startTimestamp1484253327395__endTimestamp 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | ------- Summary: start ------- 12:35:27 INFO - PROCESS | 1654 | Number of tests: 14 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:118.60 Median:114.00 stddev:13.38 (11.7%) stddev-sans-first:13.91 12:35:27 INFO - PROCESS | 1654 | Values: 111.0 114.0 114.0 115.0 113.0 114.0 114.0 121.0 156.0 114.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:120.60 Median:113.00 stddev:17.51 (15.5%) stddev-sans-first:15.75 12:35:27 INFO - PROCESS | 1654 | Values: 147.0 112.0 112.0 150.0 114.0 110.0 111.0 112.0 138.0 100.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:184.00 Median:185.00 stddev:1.33 (0.7%) stddev-sans-first:1.36 12:35:27 INFO - PROCESS | 1654 | Values: 183.0 185.0 185.0 185.0 184.0 185.0 184.0 181.0 185.0 183.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:69.50 Median:72.50 stddev:13.54 (18.7%) stddev-sans-first:13.92 12:35:27 INFO - PROCESS | 1654 | Values: 79.0 59.0 59.0 87.0 60.0 66.0 49.0 66.0 88.0 82.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:76.50 stddev:8.76 (11.4%) stddev-sans-first:7.53 12:35:27 INFO - PROCESS | 1654 | Values: 90.0 71.0 85.0 69.0 68.0 69.0 84.0 69.0 67.0 82.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:87.00 stddev:1.69 (1.9%) stddev-sans-first:1.76 12:35:27 INFO - PROCESS | 1654 | Values: 87.0 85.0 89.0 86.0 88.0 84.0 87.0 85.0 87.0 84.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:94.00 stddev:20.01 (21.3%) stddev-sans-first:19.18 12:35:27 INFO - PROCESS | 1654 | Values: 127.0 151.0 94.0 94.0 93.0 94.0 94.0 94.0 92.0 93.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:99.50 Median:86.00 stddev:22.01 (25.6%) stddev-sans-first:20.59 12:35:27 INFO - PROCESS | 1654 | Values: 129.0 132.0 133.0 87.0 86.0 85.0 87.0 84.0 86.0 86.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.50 stddev:3.20 (5.9%) stddev-sans-first:1.32 12:35:27 INFO - PROCESS | 1654 | Values: 45.0 56.0 52.0 53.0 54.0 55.0 56.0 54.0 54.0 55.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.00 stddev:3.00 (4.2%) stddev-sans-first:2.79 12:35:27 INFO - PROCESS | 1654 | Values: 67.0 68.0 77.0 75.0 72.0 70.0 71.0 70.0 70.0 71.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:93.80 Median:86.50 stddev:9.13 (10.6%) stddev-sans-first:9.23 12:35:27 INFO - PROCESS | 1654 | Values: 86.0 86.0 85.0 87.0 90.0 90.0 96.0 108.0 108.0 102.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:141.50 stddev:12.09 (8.5%) stddev-sans-first:12.75 12:35:27 INFO - PROCESS | 1654 | Values: 141.0 141.0 140.0 143.0 142.0 141.0 141.0 138.0 179.0 142.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.50 stddev:2.21 (1.3%) stddev-sans-first:1.90 12:35:27 INFO - PROCESS | 1654 | Values: 180.0 179.0 176.0 176.0 172.0 176.0 177.0 175.0 177.0 175.0 12:35:27 INFO - PROCESS | 1654 | 12:35:27 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.05 (1.6%) stddev-sans-first:1.12 12:35:27 INFO - PROCESS | 1654 | Values: 68.0 68.0 70.0 67.0 69.0 68.0 68.0 68.0 66.0 68.0 12:35:27 INFO - PROCESS | 1654 | -------- Summary: end -------- 12:35:27 INFO - PROCESS | 1654 | 12:35:28 INFO - TEST-INFO | 1654: exit 0 12:35:28 INFO - TEST-OK | kraken | took 60113ms 12:35:28 INFO - SUITE-END | took 1180s 12:35:28 INFO - Completed test suite (00:19:40) 12:35:28 INFO - javascript benchmark 12:35:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.5594816725675, 3207.5669784579077, 3362.2603027333985, 3367.0, 3431.4166591679414, 5576.079946808772, 5656.802011929583, 5694.658320500773, 5697.287839020118, 5750.511206547438, 5653.349864765543, 5686.2039314496005, 5761.0494268445655, 5761.625494342865, 5795.420457954203, 3629.6733294003534, 5135.512126347991, 5156.561692256163, 5205.869853253661, 5282.286891269668, 5087.84736457905, 5278.049951008817, 5289.841304760864, 5309.7610607522565, 5362.51737343639, 5106.693598384071, 5269.420363759983, 5284.815031473919, 5290.92063619046, 5319.095753721857, 5160.071187186305, 5191.2472691459525, 5197.584193264567, 5217.191335343028, 5242.397124330712, 5139.203423469368, 5174.7412629368755, 5196.29849970253, 5196.558292545138, 5237.004969055867, 5731.656100633933, 5737.426257374229, 5753.309602847643, 5753.338366087912, 5822.0, 6121.584937613601, 6179.412955769195, 6196.504279657662, 6261.812145635638, 6297.118403423525, 6268.49852011838, 6292.874142517124, 6313.810585682437, 6338.239411270631, 6352.841178970517, 5901.996660567671, 5904.409559044104, 5907.0, 5924.46653432638, 5957.404259574095, 6244.406781355764, 6252.249730032425, 6303.810885673437, 6307.842303942438, 6346.619202847844, 6092.908606370908, 6111.326590486452, 6123.44547193875, 6125.235451818339, 6130.593106200482, 6139.171211886338, 6221.782237621662, 6267.091271765568, 6276.748930042839, 6330.841728956813, 6096.603720758137, 6126.540509461808, 6144.938550614526, 6153.707721378561, 6163.044728067157, 5399.352077750695, 6069.393060693896, 6179.28938172107, 6227.906581401283, 6274.466670332981, 4948.0, 4967.230079337708, 4978.6763860348965, 4986.700797952134, 5009.724465154379, 4412.294032954712, 4423.977880110579, 4463.218936686067, 4469.597736203692, 4565.246734288805, 5057.519535644108, 5689.743961521742, 5708.086706127, 5730.111832665943, 5819.53443724501, 5995.52035837132, 6126.969365153146, 6260.285073654789, 6317.431431171217, 6318.462930650946, 5719.828405147852, 5748.0, 5750.108733146369, 5757.942420575824, 5791.82624521265, 5349.919751203735, 5380.91928621071, 5386.542143917733, 5403.0, 5443.972780136074, 5272.6836389816735, 6251.0, 6294.937050629435, 6295.559310848288, 6323.557350985571, 6300.810975670737, 6306.842328941813, 6318.62088274705, 6336.144620476177, 6342.270638876588, 5336.0, 6335.524835637253, 6341.90487142684, 6350.555461117678, 6357.046443033582, 6081.179040829608, 6104.084387341934, 6250.593711408744, 6260.436560709558, 6275.560710750204, 6232.626042437469, 6241.0, 6282.937170628235, 6337.4613157882095, 6347.238331400262, 4758.286257061469, 5985.0, 6130.080487926846, 6159.876802463836, 6162.630242185483, 5964.493018093337, 6186.041163619646, 6191.721372538336, 6212.161358216583, 6217.0, 5840.853978650568, 5883.55873309512, 5974.074018527135, 6000.189974353407, 6039.214902062704, 6063.363346848518, 6069.4840938518955, 6104.0347610180015, 6107.310189946561, 6127.769884593477, 5931.377205393372, 5982.46157845796, 6001.729922153426, 6004.729787159676, 6012.6993650316435], "value": 5684.216446388284, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.3305871368154, 488.45049319515545, 501.7416030744166, 508.8117396563271, 518.9429162792093, 24603.384915377126, 38788.22423551531, 40567.59432405679, 40676.779696609075, 42974.14051718964, 35342.2931541369, 43438.91402714934, 43444.0, 43553.0, 43636.56363436364, 9016.188543031127, 9231.353805233637, 9235.12266334697, 9244.214241789456, 9254.398464099811, 8345.54099524526, 8565.828683426327, 11013.724656883602, 11242.381669008202, 11255.380954047525, 11191.496382662799, 11207.66377008691, 11217.439128043607, 11281.37952412617, 11288.322700637988, 8380.83238335236, 11204.383758893258, 11231.438428078603, 11242.775144497064, 11287.209895307331, 8381.832363352698, 10834.67495975122, 11055.336679799238, 11069.667909962714, 11275.943620281929, 40181.19637607261, 40467.7976610118, 40578.0, 40629.796851015555, 40655.1868962622, 3988.980055099706, 4004.8798536043964, 4014.6186112319283, 4029.625226028579, 4061.6547593454297, 30120.0, 30380.0, 30451.543226851616, 30992.225194370094, 31370.0, 2975.61317028787, 3175.4760464523556, 3192.377486390155, 3283.688049635281, 3328.251143492719, 406190.0, 445490.0, 449702.0, 450594.0, 452698.0, 61382.38617613856, 62483.68758156271, 62653.0, 62999.0, 63042.68478657577, 65512.0, 65603.0, 65618.67190664016, 65663.67168164224, 65723.01415478771, 15067.397304107932, 15676.0, 16159.192040397933, 16215.513534593982, 16219.107949062678, 11147.777044459066, 11383.487743051583, 12118.757624847454, 12182.939085304517, 12212.267263964191, 14522.636934076732, 15617.453389131326, 16239.756403653955, 16676.416325428552, 17498.825011749974, 6622.205335359788, 6640.734370625121, 6647.534672572873, 6675.899861502081, 6711.0, 883.3198437203317, 886.1448702002598, 904.8235594059227, 914.6341463414554, 930.9441433514011, 29915.117460696838, 30074.248143796143, 30243.69756302453, 30566.84716576403, 30828.0, 1071.6517131932153, 1074.1084899533369, 1109.1071687291646, 1116.3580940958818, 1225.24789550943, 13313.600591982256, 15413.537593871977, 15683.921580392025, 15716.764248536281, 16115.355385784438, 558986.0, 568254.0, 570333.0, 570506.0, 571468.0, 60838.0, 60915.695421523495, 61064.694676526335, 61119.69440152771, 61231.77536449246, 1291.1155858237137, 1421.3390773290469, 1434.7704367301183, 1462.3200211901517, 1471.4849802569015, 24553.772311384717, 24688.753112469363, 28879.85560072186, 29472.7895407841, 30301.393972120874, 51651.0, 52047.73976130095, 52126.47873521368, 52161.47838521566, 52267.73866130645, 481438.0, 482460.0, 482830.0, 482896.0, 482914.0, 19770.90114549418, 24496.38759030967, 24699.753002469744, 40437.95620437933, 40823.79588102041, 41216.79391603023, 41280.0, 41666.79166604148, 41845.37231941462, 43063.35404968991, 35534.289314213056, 35625.643743562236, 36328.0, 37008.629913701596, 37022.0, 34774.82612586921, 35420.0, 36067.819660902576, 36081.097972550895, 36362.63637363593, 33711.15722106967, 34176.82911585426, 34830.30339393249, 34832.0, 34875.4768678465, 30830.229244269074, 31564.210894726897, 31786.682133179296, 31882.52176217312, 31908.6809131915, 22402.103915843185, 23137.60909376689, 23300.0, 23327.883360583088, 23435.41411464727], "value": 19628.42005571746, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.7209884438403, 385.59705108161967, 387.59496326338973, 392.70154682441347, 419.2851188723227, 15231.0, 15310.311036003379, 18146.455606331798, 20555.794442055576, 20667.0, 19156.233750649957, 21119.260825871097, 21186.046627901742, 21716.782832171673, 21752.238671646497, 5202.245674377223, 5294.973525132388, 5367.677939323634, 5372.086745253297, 5913.14259432382, 3203.4073696366245, 5797.275340582427, 5897.793577224798, 5899.056151015839, 5900.055991041413, 4031.23406552754, 4085.142120154771, 4087.2847251730977, 4087.652549533293, 4092.7953602319913, 4039.9798001009954, 6548.377904099079, 6602.93397066028, 6603.273639899608, 6634.336566343375, 5643.887122257573, 5698.173764804122, 5768.0, 5868.09044598088, 5889.322727886305, 13356.332183390792, 13439.395227214702, 13494.86505134946, 13508.932455337661, 13557.661058473519, 2576.2400091972913, 2601.4666993266337, 2644.2067379785985, 2725.2505560970694, 2742.3966727319957, 10292.588296468133, 10317.329373590692, 10322.638707645196, 10855.620053298175, 11988.70028249292, 1866.6546688862604, 1881.3039175505014, 1881.8212269834344, 1906.809319068082, 1941.213808407597, 131889.0, 141010.0, 142023.0, 144084.0, 144545.27727361402, 11391.316521008766, 11684.0, 11855.822162667568, 11892.565278054682, 11920.344381058952, 15804.525864224091, 15807.68384632324, 15852.207389630472, 15889.841101588836, 15893.523194304189, 8428.704995325133, 8601.354898382646, 8675.305975521944, 8712.651493940171, 8723.171298726611, 8218.137095604876, 8229.46508476947, 8269.0, 8412.625434773883, 8419.789505262417, 4681.555252251031, 4759.714417134983, 4763.309320148559, 4780.139574876486, 4862.440819305754, 1951.9024048797787, 2008.2067583304513, 2010.256205204084, 2012.1488230827674, 2013.365789776245, 860.3160487412522, 880.7665968518347, 882.8787439951226, 893.1782759860944, 919.4621146629297, 18777.436676899713, 20666.483337916674, 21854.934720125824, 24060.759392406202, 24224.75775242225, 925.4817302310728, 998.7553049502918, 1045.1220974381556, 1057.2916146182076, 1079.6005477973042, 9907.207423406111, 10801.891981080245, 11210.977973655614, 11216.522877907875, 11274.605388811353, 595326.0, 723831.0, 724048.5570865765, 738772.3061384659, 740325.0, 106580.9341906571, 109412.0, 139191.0, 139748.0, 145518.27240863728, 1094.3269889018197, 1110.6223883879682, 1140.1107136433595, 1140.4810811080938, 1146.415328182633, 15562.610934726723, 16707.24817383245, 18579.721304180177, 18698.43904682862, 19595.902020489808, 51828.74085629548, 55198.44801551933, 55534.0, 55949.0, 56034.15948760854, 75911.24088759262, 76275.61862190654, 77283.61358193398, 77687.61156194408, 77887.83168252594, 7474.364679002346, 8143.104258531438, 8144.877826832484, 8381.580920953806, 8627.741167764978, 8086.1913808618665, 11974.760504789681, 12887.09790314669, 13281.66795830112, 13438.731225375634, 10861.239713219999, 11266.774664506827, 11472.369019703663, 11519.481623327138, 11602.825957610812, 10998.780024399308, 11145.83281250798, 11382.37396943143, 11466.069237533015, 11613.6515904523, 11198.888011119785, 11245.775084498428, 11452.885471145182, 11678.766424671288, 11746.823797643214, 6861.485388595976, 8233.629486673233, 8281.254687078192, 8378.916210837813, 8425.452345597516, 7632.3512501438, 10780.784384312426, 11193.552257909592, 11342.149338799789, 11399.715007124889], "value": 9504.539961962284, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.0920628575711, 1440.9279536023203, 1460.2260801775062, 1465.721512912546, 1471.382019551788, 8099.4330396872165, 8469.95765021174, 8498.022727386353, 8515.276201522878, 8524.659013639446, 7423.0, 7699.345555627779, 7715.267049630276, 8156.469829461095, 8386.832263354729, 2294.128231272114, 2321.1063740459876, 2328.2200462844967, 2334.743178250391, 2339.532093581282, 2291.702078729763, 2328.3364241191266, 2333.8132949364094, 2342.367560758594, 2342.5080733045997, 2004.7995200479982, 2080.3238947342097, 2252.8986195621237, 2302.7121609798774, 2326.6975293211945, 2257.661350797377, 2259.062489067035, 2261.8416710830247, 2267.5238199978025, 2272.7727227277305, 2253.1438053539714, 2303.309007297804, 2341.3210169050953, 2348.659444380555, 2348.823838212141, 8448.0, 8513.659453621847, 8522.914770852274, 8525.488470691778, 8525.786855328604, 5063.063333283318, 5219.582433405319, 5220.295260139908, 5223.608229382811, 5228.712420816853, 3305.9504107438406, 3463.5497385339745, 3489.94765078524, 3556.217632120955, 3563.1448452371505, 969.2536746704998, 1200.8203624258185, 1202.9518819247219, 1251.1429670675616, 1252.9812052819216, 10792.946035269773, 10903.563857445693, 10951.0, 10969.0, 10987.670369888996, 4462.888427789267, 4599.885002874955, 4680.695754775928, 4685.929711054337, 4695.154872122982, 9612.615495380247, 9626.229901607854, 9626.855597166048, 9627.0, 9642.276829237835, 5274.7098909560345, 5276.34045744282, 5277.287566178594, 5281.39263984639, 5301.1783173608155, 4059.715819892638, 4283.614474697292, 4353.190076748121, 4757.238841785367, 4796.736179510091, 3794.9241015180096, 3844.3464611016193, 3896.629820167136, 3934.901627459279, 3938.448617193595, 1071.3678929431674, 1278.9360531973364, 1280.6734282758023, 1286.8777466140702, 1298.2794549025382, 861.3496809908604, 898.9415687980392, 911.5533388639651, 917.8118485710413, 938.9765255868658, 4428.623566996777, 5525.518923078434, 5657.858553536113, 5683.516901063456, 5765.221695071112, 561.7668667502941, 574.3653263144249, 574.4284436985226, 574.4973148495067, 585.2012003615035, 3680.411134218512, 3759.755615884959, 3797.696184305304, 3803.0, 3835.4246862970776, 9446.574904129331, 9916.0, 9988.400695958266, 10127.64553240633, 10166.0, 9852.16256618181, 9943.005699430143, 10070.496475176213, 10074.546645400975, 10096.14182794456, 7608.391328693691, 7799.259070388304, 7814.3748500119855, 7925.841483170304, 7947.721829735931, 5446.700431476148, 5468.808591699271, 5470.015397228537, 5517.475839795213, 5552.7223638818705, 7759.883601746092, 7979.48133371329, 9064.546772661472, 9145.817083658423, 9478.004809494903, 8104.27061564462, 8432.988041435066, 8926.910730892867, 9073.727788166365, 9576.616935322509, 6006.759729610767, 6615.206175258807, 6857.108575885302, 6864.828379290558, 7290.927090729237, 7660.923390766021, 7964.482308649919, 7984.441089123706, 8077.27304542594, 8115.391345648982, 6897.965510172417, 7071.611061391673, 7215.989761433299, 7311.049563556704, 7338.339549440576, 6930.861382772216, 7024.402925751164, 7063.611501367269, 7136.036635054201, 7156.248593897566, 5367.946320536901, 6269.31037585856, 6409.903851442139, 6482.773102941374, 6498.090267362668, 4965.354503914468, 5000.449950505515, 5016.648834581544, 5069.619778516552, 5110.795568177231, 4722.480527141943, 4778.307145463818, 4885.438174609965, 5020.949790502048, 5027.673201241908], "value": 4334.5925573651, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.5822668510853, 341.8235799671851, 360.2830367568538, 367.8418280139542, 368.76583369560336, 5152.742362881855, 5236.84289471316, 5292.603054770893, 5340.264414065435, 5354.705491197982, 4212.726172798766, 4536.27419612862, 5244.737763111848, 5286.704757334449, 5303.401333346661, 3397.4032204863674, 3483.599386070596, 4032.9798351008203, 4079.5522686388153, 4089.7137200395982, 3478.339115568034, 3676.411774116142, 3767.9058023549355, 3986.6611338036155, 4029.7179197456044, 3962.8600555699886, 3967.2065586882595, 3971.299516328895, 3974.6224108709625, 3985.8007099645047, 3181.3319202967405, 3237.4981877808978, 3599.136207310227, 3927.705422093326, 3951.901202469947, 2923.2606599073515, 3052.0628389377675, 3092.912284208173, 3112.6576076631554, 3191.250056236806, 4475.977620111911, 5134.358205224347, 5135.64050516464, 5137.717425541631, 5172.517191747945, 4198.349255865346, 4561.817527298904, 4572.736495434748, 4576.748278844662, 4581.79381927814, 5242.0, 5531.612787104904, 5599.384067752544, 5606.943930560683, 5638.577106716972, 3527.682508574215, 3829.5596006459054, 3833.5016447861876, 3851.4415409765706, 3858.4405261237243, 5458.781648734085, 5889.027175896037, 5913.121674618457, 5913.763449461973, 5926.377730338339, 3225.9677403226137, 3229.9192520187185, 3567.8216089195435, 3841.5774264830848, 3879.4568760373572, 3951.209758048344, 3951.9012024699614, 3954.6045395460224, 3966.1671049080014, 3972.3842804365368, 4561.338605902126, 4561.657875659339, 4576.199165146086, 4589.862304130881, 4614.031053478807, 5463.606780271085, 5552.880126585982, 5576.247206627135, 5641.984442800335, 5678.545716342683, 1171.8710941796396, 1193.76721539299, 1264.867943190839, 1273.4269578689627, 1273.7452509498137, 729.3727394440776, 850.3248600257606, 852.1691350932791, 864.4078806017898, 867.4361664917727, 4880.731559764247, 4895.111883988464, 4954.281629163823, 5044.016416798689, 5069.695818250843, 4699.694519856198, 5192.015664961679, 5416.641682157009, 5714.371419143891, 5738.311402631627, 5136.332276803992, 5154.896902061938, 5160.148575485078, 5164.870878228075, 5175.404828444702, 2408.0969636386353, 2554.0805310088354, 2594.6648016785043, 2799.636047313836, 2853.4007858349564, 5126.4620613815705, 5289.788408463695, 5688.431156884361, 5693.743781529841, 5709.200711900337, 4683.531646835289, 4866.926996095061, 5377.462253774669, 5464.0, 5634.971825140848, 4904.2589880593305, 5232.9738351308, 5644.435556444323, 5707.514861236758, 5737.483626473638, 4842.346283251857, 5042.058807359266, 5269.420363759907, 5482.1624862595545, 5498.945010549844, 4665.320484625464, 5029.874253143701, 5159.767810448614, 5289.100852854947, 5340.465953404629, 5120.107139466189, 5125.513076257749, 5323.1216849219445, 5696.259486266758, 5738.192469372135, 3311.7019468247972, 3458.996890901711, 3712.934336901089, 3962.3065963456856, 3976.661983731415, 4731.479537250969, 4892.510748925079, 5253.660316619391, 5291.894162116813, 5465.6447330923365, 5073.231162707044, 5199.220116982483, 5248.168836749118, 5314.721649072534, 5318.8936221276135, 4491.865244042684, 5181.663191892515, 5233.760653870378, 5260.789568417221, 5323.494268044529, 4351.717138385995, 4618.330342100444, 4705.882352941258, 4988.825391111293, 5177.427574973256, 4358.978205108954, 5000.724091265584, 5269.257668098742, 5337.599680023936, 5353.143497040455, 4389.780510974502, 4786.617070634411, 4863.975680121577, 5483.8080667176455, 5514.91727624078], "value": 3945.6609033601726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.8158737934451, 706.9007693037331, 765.7396485195032, 813.3940214540169, 819.5410570080753, 14722.411103555858, 15691.60770980726, 15985.040897546127, 16090.356385744572, 16257.75613365799, 14281.07173033752, 14605.415783368653, 14820.777688334683, 14847.554573362817, 14851.257437128128, 857.3141486810558, 872.0799556467924, 876.9824603507926, 877.5085951866943, 877.868319752036, 652.9510286728514, 698.5773606967788, 716.7204790131852, 720.3840716187663, 873.7335112790596, 918.6509126531909, 930.6463543853326, 933.2953620016912, 935.1536859142487, 936.5410948635154, 926.1942110363959, 926.5135803703042, 926.5969303353063, 927.554773708617, 927.7958849053198, 534.3907944942769, 550.9256250406224, 663.4659099424961, 690.4648897104734, 691.5470366909682, 15110.093394396372, 15544.844551554454, 15757.763633545506, 15766.369345226178, 15778.842211577852, 14015.929920350434, 14135.293235338191, 14187.148771073666, 14199.36102875373, 14292.642683932881, 12875.67810804728, 12956.0, 13016.804747928789, 13048.412821423059, 13366.198028118344, 3492.807895565743, 3851.5185601799776, 4616.238320677085, 4667.95332046682, 4692.366530518405, 101639.98360016453, 102029.0, 104393.95606043919, 106322.0, 107946.0629665368, 10868.076213521781, 10889.782204355868, 10978.725531861608, 11000.449977501094, 11228.045616122721, 19818.0, 21321.573568528544, 21329.46676333073, 21345.78654213438, 21359.0, 6462.903056454157, 7413.258674132544, 7509.586972716553, 7579.583122928292, 7647.349975252166, 4149.170165966819, 4205.137946720914, 4231.703780735381, 4324.13517296542, 4329.350597410414, 3365.2764655599162, 3397.252604427022, 3434.7252219822353, 3440.3119376124873, 3467.7745946513396, 630.1146888621494, 632.3107812484415, 638.2978723404311, 656.4551422319463, 656.8390744267685, 559.3846768554639, 639.7269433826651, 644.5455953552735, 652.8270008447765, 664.4651055900047, 8121.593920303962, 8374.958125209336, 9136.451812891248, 9531.618735250513, 9876.35803672759, 614.7049416280121, 637.416763661254, 644.1593720195096, 648.2480322825594, 669.4769399615913, 4441.489228738672, 4716.481187069419, 4724.267738500538, 4727.196376615983, 4749.786259618326, 100881.0, 103600.05786430808, 106426.93573064171, 107703.46148269209, 107961.92038079676, 73974.26025739781, 74630.25369746341, 75519.62240188874, 92543.53728231316, 94059.0, 81465.59267203626, 83680.58159709163, 83769.58115209384, 83814.58092709619, 85509.71735423974, 9043.457392556467, 9265.53672316368, 9289.914562312513, 9385.296102792181, 9392.530373481162, 52656.21015684844, 53186.0, 55378.0, 55636.57991673154, 55675.72162139163, 60373.79252415015, 72381.6380918092, 73542.63228684037, 73684.26315736774, 74097.0, 10830.67507974762, 10888.836667449836, 10926.344419334866, 11162.0, 11164.274322169033, 11539.911506180559, 11560.768784624428, 11598.94200528992, 11872.584459543874, 12061.577844775391, 11262.662120136409, 11797.941010294893, 11831.230969986924, 11851.051915846883, 12270.877291226974, 9757.31698781107, 11077.279976801483, 11602.767944640891, 12140.028797695986, 12184.878151218729, 11431.771364572829, 11548.0761539075, 11856.644300670994, 11881.22772019816, 11919.0, 9502.334836561651, 9502.952485237529, 9571.569279382305, 10057.647982320876, 10059.547320370455, 7973.978807894086, 9290.674826381044, 9372.95313523428, 9373.625054997723, 9472.905270947202], "value": 7260.846560894854, "unit": "score"}], "name": "dromaeo_css", "value": 7132.884954772472, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 114.0, 115.0, 113.0, 114.0, 114.0, 121.0, 156.0, 114.0], "value": 118.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 112.0, 112.0, 150.0, 114.0, 110.0, 111.0, 112.0, 138.0, 100.0], "value": 120.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 185.0, 185.0, 184.0, 185.0, 184.0, 181.0, 185.0, 183.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 87.0, 60.0, 66.0, 49.0, 66.0, 88.0, 82.0], "value": 69.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 85.0, 69.0, 68.0, 69.0, 84.0, 69.0, 67.0, 82.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 89.0, 86.0, 88.0, 84.0, 87.0, 85.0, 87.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 151.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 92.0, 93.0], "value": 102.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 132.0, 133.0, 87.0, 86.0, 85.0, 87.0, 84.0, 86.0, 86.0], "value": 99.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 56.0, 52.0, 53.0, 54.0, 55.0, 56.0, 54.0, 54.0, 55.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 77.0, 75.0, 72.0, 70.0, 71.0, 70.0, 70.0, 71.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 87.0, 90.0, 90.0, 96.0, 108.0, 108.0, 102.0], "value": 93.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 141.0, 140.0, 143.0, 142.0, 141.0, 141.0, 138.0, 179.0, 142.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 179.0, 176.0, 176.0, 172.0, 176.0, 177.0, 175.0, 177.0, 175.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 67.0, 69.0, 68.0, 68.0, 68.0, 66.0, 68.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1463.8, "alertThreshold": 2.0}]} 12:35:28 INFO - Return code: 0 12:35:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:35:28 INFO - # TBPL SUCCESS # 12:35:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:35:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:35:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:35:28 INFO - 2017-01-12 12:35:28.697 screenresolution[1658:9770] starting screenresolution argv=screenresolution get 12:35:28 INFO - 2017-01-12 12:35:28.701 screenresolution[1658:9770] Display 0: 1600x1200x32@60 12:35:28 INFO - 2017-01-12 12:35:28.708 screenresolution[1659:9773] starting screenresolution argv=screenresolution list 12:35:28 INFO - Available Modes on Display 0 12:35:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:35:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:35:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:35:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:35:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:35:28 INFO - Intel Iris: 12:35:28 INFO - Chipset Model: Intel Iris 12:35:28 INFO - Type: GPU 12:35:28 INFO - Bus: Built-In 12:35:28 INFO - VRAM (Dynamic, Max): 1536 MB 12:35:28 INFO - Vendor: Intel (0x8086) 12:35:28 INFO - Device ID: 0x0a2e 12:35:28 INFO - Revision ID: 0x0009 12:35:28 INFO - Displays: 12:35:28 INFO - Display: 12:35:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:35:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:35:28 INFO - Display Serial Number: 1600x1200 60 12:35:28 INFO - Main Display: Yes 12:35:28 INFO - Mirror: Off 12:35:28 INFO - Online: Yes 12:35:28 INFO - Rotation: Supported 12:35:28 INFO - Return code: 0 12:35:28 INFO - Running post-action listener: _resource_record_post_action 12:35:28 INFO - [mozharness: 2017-01-12 20:35:28.944725Z] Finished run-tests step (success) 12:35:28 INFO - Running post-run listener: _resource_record_post_run 12:35:29 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 37377024; Write bytes: 554533376; Read time: 250; Write time: 1671 12:35:29 INFO - TinderboxPrint: CPU usage
53.9% 12:35:29 INFO - TinderboxPrint: I/O read bytes / time
37,377,024 / 250 12:35:29 INFO - TinderboxPrint: I/O write bytes / time
554,533,376 / 1,671 12:35:29 INFO - TinderboxPrint: CPU idle
2,217.9 (46.1%) 12:35:29 INFO - TinderboxPrint: CPU system
966.6 (20.1%) 12:35:29 INFO - TinderboxPrint: CPU user
1,629.3 (33.8%) 12:35:29 INFO - TinderboxPrint: Swap in / out
288,940,032 / 0 12:35:29 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 245531136; Write bytes: 237813760; Read time: 17951; Write time: 493 12:35:29 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35304448; Write bytes: 299121152; Read time: 221; Write time: 1118 12:35:29 INFO - Running post-run listener: _upload_blobber_files 12:35:29 INFO - Blob upload gear active. 12:35:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:35:29 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:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:35:29 INFO - (blobuploader) - INFO - Open directory for files ... 12:35:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:35:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:35:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:30 INFO - (blobuploader) - INFO - Done attempting. 12:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:31 INFO - (blobuploader) - INFO - Done attempting. 12:35:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:35:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:35:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:32 INFO - (blobuploader) - INFO - Done attempting. 12:35:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:35:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:35:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:34 INFO - (blobuploader) - INFO - Done attempting. 12:35:34 INFO - (blobuploader) - INFO - Iteration through files over. 12:35:34 INFO - Return code: 0 12:35:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:35:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:35:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/452c785fb9edab39465e25aae942afcd7474d14bf4a915b89fe8cc0882d1dc2fc8b1f5950b99763faf6d146e693a8ef5040232dc583216ad84fc51dc215a9893", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4841fda1f59583beec4868c44a6f0bccbdfa424f0437086e1116c66ef4e0e3c4970245049f017ce30493bc27cf038bbcd866d6065d741c0d24ef706017b97ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac14143128527adab9b6868421df64c2c0b3f48fc67f94d7863049e80f7e0a0f8fcda10cfe4c2bef68a695b4de8175bf5733bfe9174ef74d63f4c3f8289ebf8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2811b419fe802d2853aca217d259373d0cd1503ad238eee6f2ac47678374d8c3d28c00b1fb3a54ac9ba9f11bea2fcb1297a441624f7f0f9fbf1afb737fef64a"} 12:35:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:35:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:35:34 INFO - Contents: 12:35:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/452c785fb9edab39465e25aae942afcd7474d14bf4a915b89fe8cc0882d1dc2fc8b1f5950b99763faf6d146e693a8ef5040232dc583216ad84fc51dc215a9893", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4841fda1f59583beec4868c44a6f0bccbdfa424f0437086e1116c66ef4e0e3c4970245049f017ce30493bc27cf038bbcd866d6065d741c0d24ef706017b97ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac14143128527adab9b6868421df64c2c0b3f48fc67f94d7863049e80f7e0a0f8fcda10cfe4c2bef68a695b4de8175bf5733bfe9174ef74d63f4c3f8289ebf8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2811b419fe802d2853aca217d259373d0cd1503ad238eee6f2ac47678374d8c3d28c00b1fb3a54ac9ba9f11bea2fcb1297a441624f7f0f9fbf1afb737fef64a"} 12:35:34 INFO - Running post-run listener: copy_logs_to_upload_dir 12:35:34 INFO - Copying logs to upload dir... 12:35:34 INFO - mkdir: /builds/slave/test/build/upload/logs 12:35:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.688111 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-12 12:35:34.839705) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 12:35:34.843264) ========= 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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/452c785fb9edab39465e25aae942afcd7474d14bf4a915b89fe8cc0882d1dc2fc8b1f5950b99763faf6d146e693a8ef5040232dc583216ad84fc51dc215a9893", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4841fda1f59583beec4868c44a6f0bccbdfa424f0437086e1116c66ef4e0e3c4970245049f017ce30493bc27cf038bbcd866d6065d741c0d24ef706017b97ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac14143128527adab9b6868421df64c2c0b3f48fc67f94d7863049e80f7e0a0f8fcda10cfe4c2bef68a695b4de8175bf5733bfe9174ef74d63f4c3f8289ebf8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2811b419fe802d2853aca217d259373d0cd1503ad238eee6f2ac47678374d8c3d28c00b1fb3a54ac9ba9f11bea2fcb1297a441624f7f0f9fbf1afb737fef64a"} build_url:https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/JMUWQq0vQEmjS9MnKwATUA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/452c785fb9edab39465e25aae942afcd7474d14bf4a915b89fe8cc0882d1dc2fc8b1f5950b99763faf6d146e693a8ef5040232dc583216ad84fc51dc215a9893", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4841fda1f59583beec4868c44a6f0bccbdfa424f0437086e1116c66ef4e0e3c4970245049f017ce30493bc27cf038bbcd866d6065d741c0d24ef706017b97ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aac14143128527adab9b6868421df64c2c0b3f48fc67f94d7863049e80f7e0a0f8fcda10cfe4c2bef68a695b4de8175bf5733bfe9174ef74d63f4c3f8289ebf8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d2811b419fe802d2853aca217d259373d0cd1503ad238eee6f2ac47678374d8c3d28c00b1fb3a54ac9ba9f11bea2fcb1297a441624f7f0f9fbf1afb737fef64a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 12:35:34.877884) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:35:34.878284) ========= 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.Hq4W9Tp634/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.Iwjl1CuJQc/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.005345 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 12:35:34.929758) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 12:35:34.930250) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 12:35:34.930859) ========= ========= Total master_lag: 0.20 =========