builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0112 starttime: 1490496583.96 results: success (0) buildid: 20170325184016 builduid: db823f610039467ea9c398597559edc7 revision: f5e214144799889e2408c4841351f4053f00544e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:43.958745) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:43.959236) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:43.959524) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:44.068768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:44.069077) ========= 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.nXjTCtrAY8/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.zfluheiGEo/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-03-25 19:49:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.9M=0.001s 2017-03-25 19:49:44 (13.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.502605 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:44.595877) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:44.596181) ========= 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.nXjTCtrAY8/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.zfluheiGEo/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.028251 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:44.646258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-25 19:49:44.646594) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f5e214144799889e2408c4841351f4053f00544e --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 f5e214144799889e2408c4841351f4053f00544e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nXjTCtrAY8/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.zfluheiGEo/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-03-25 19:49:44,754 truncating revision to first 12 chars 2017-03-25 19:49:44,754 Setting DEBUG logging. 2017-03-25 19:49:44,754 attempt 1/10 2017-03-25 19:49:44,754 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f5e214144799?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-25 19:49:45,863 unpacking tar archive at: mozilla-central-f5e214144799/testing/mozharness/ program finished with exit code 0 elapsedTime=1.386027 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-25 19:49:46.055996) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:46.056295) ========= script_repo_revision: f5e214144799889e2408c4841351f4053f00544e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:46.056695) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:46.056964) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-25 19:49:46.076656) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-25 19:49:46.076921) ========= /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.nXjTCtrAY8/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.zfluheiGEo/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 19:49:46 INFO - MultiFileLogger online at 20170325 19:49:46 in /builds/slave/test 19:49:46 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 19:49:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:49:46 INFO - {'append_to_log': False, 19:49:46 INFO - 'base_work_dir': '/builds/slave/test', 19:49:46 INFO - 'blob_upload_branch': 'Firefox', 19:49:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:49:46 INFO - 'branch': 'Firefox', 19:49:46 INFO - 'buildbot_json_path': 'buildprops.json', 19:49:46 INFO - 'config_files': ('talos/mac_config.py',), 19:49:46 INFO - 'default_actions': ('clobber', 19:49:46 INFO - 'read-buildbot-config', 19:49:46 INFO - 'download-and-extract', 19:49:46 INFO - 'populate-webroot', 19:49:46 INFO - 'create-virtualenv', 19:49:46 INFO - 'install', 19:49:46 INFO - 'run-tests'), 19:49:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:49:46 INFO - 'download_minidump_stackwalk': True, 19:49:46 INFO - 'download_symbols': 'ondemand', 19:49:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:49:46 INFO - 'tooltool.py': '/tools/tooltool.py', 19:49:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:49:46 INFO - '/tools/misc-python/virtualenv.py')}, 19:49:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:49:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:49:46 INFO - 'gecko_profile': False, 19:49:46 INFO - 'gecko_profile_interval': 0, 19:49:46 INFO - 'installer_path': 'installer.exe', 19:49:46 INFO - 'log_level': 'info', 19:49:46 INFO - 'log_name': 'talos', 19:49:46 INFO - 'log_to_console': True, 19:49:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:49:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:49:46 INFO - 'opt_config_files': (), 19:49:46 INFO - 'pip_index': False, 19:49:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:49:46 INFO - 'cmd': ('bash', 19:49:46 INFO - '-c', 19:49:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:49:46 INFO - 'enabled': True, 19:49:46 INFO - 'halt_on_failure': False, 19:49:46 INFO - 'name': 'check_screen_resolution'},), 19:49:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:49:46 INFO - 'cmd': ('bash', 19:49:46 INFO - '-c', 19:49:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:49:46 INFO - 'enabled': True, 19:49:46 INFO - 'halt_on_failure': False, 19:49:46 INFO - 'name': 'check_screen_resolution'},), 19:49:46 INFO - 'run_cmd_checks_enabled': True, 19:49:46 INFO - 'suite': 'dromaeojs', 19:49:46 INFO - 'system_bits': '32', 19:49:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:49:46 INFO - 'title': 't-yosemite-r7-0112', 19:49:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:49:46 INFO - 'use_talos_json': True, 19:49:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:49:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:49:46 INFO - 'work_dir': 'build'} 19:49:46 INFO - [mozharness: 2017-03-26 02:49:46.298510Z] Running clobber step. 19:49:46 INFO - Running pre-action listener: _resource_record_pre_action 19:49:46 INFO - Running main action method: clobber 19:49:46 INFO - rmtree: /builds/slave/test/build 19:49:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:49:48 INFO - Running post-action listener: _resource_record_post_action 19:49:48 INFO - [mozharness: 2017-03-26 02:49:48.709735Z] Finished clobber step (success) 19:49:48 INFO - [mozharness: 2017-03-26 02:49:48.709832Z] Running read-buildbot-config step. 19:49:48 INFO - Running pre-action listener: _resource_record_pre_action 19:49:48 INFO - Running main action method: read_buildbot_config 19:49:48 INFO - Using buildbot properties: 19:49:48 INFO - { 19:49:48 INFO - "project": "", 19:49:48 INFO - "product": "firefox", 19:49:48 INFO - "script_repo_revision": "production", 19:49:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:49:48 INFO - "repository": "", 19:49:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:49:48 INFO - "buildid": "20170325184016", 19:49:48 INFO - "pgo_build": "False", 19:49:48 INFO - "basedir": "/builds/slave/test", 19:49:48 INFO - "buildnumber": 14, 19:49:48 INFO - "slavename": "t-yosemite-r7-0112", 19:49:48 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:49:48 INFO - "platform": "yosemite_r7", 19:49:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:49:48 INFO - "branch": "mozilla-central", 19:49:48 INFO - "repo_path": "mozilla-central", 19:49:48 INFO - "revision": "f5e214144799889e2408c4841351f4053f00544e", 19:49:48 INFO - "stage_platform": "macosx64", 19:49:48 INFO - "builduid": "db823f610039467ea9c398597559edc7", 19:49:48 INFO - "slavebuilddir": "test" 19:49:48 INFO - } 19:49:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 19:49:48 INFO - Running post-action listener: _resource_record_post_action 19:49:48 INFO - [mozharness: 2017-03-26 02:49:48.713319Z] Finished read-buildbot-config step (success) 19:49:48 INFO - [mozharness: 2017-03-26 02:49:48.713425Z] Running download-and-extract step. 19:49:48 INFO - Running pre-action listener: _resource_record_pre_action 19:49:48 INFO - Running main action method: download_and_extract 19:49:48 INFO - mkdir: /builds/slave/test/build/tests 19:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:49:48 INFO - trying https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 19:49:48 INFO - Downloading https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:49:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 19:49:49 INFO - Downloaded 1325 bytes. 19:49:49 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:49:49 INFO - Using the following test package requirements: 19:49:49 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:49 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 19:49:49 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:49:49 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:49 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 19:49:49 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:49 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 19:49:49 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:49 INFO - u'jsshell-mac.zip'], 19:49:49 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:49 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 19:49:49 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:49:49 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:49 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 19:49:49 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:49 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 19:49:49 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:49 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 19:49:49 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:49:49 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 19:49:49 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:49:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:49:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:49:49 INFO - Fetch https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:49:51 INFO - Expected file size: 52411490 19:49:51 INFO - Obtained file size: 52411490 19:50:07 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:50:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:50:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:50:07 INFO - Fetch https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:50:10 INFO - Expected file size: 52411490 19:50:10 INFO - Obtained file size: 52411490 19:50:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 19:50:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:50:25 INFO - Fetch https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 19:50:26 INFO - Expected file size: 14404171 19:50:26 INFO - Obtained file size: 14404171 19:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:26 INFO - trying https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:50:26 INFO - Downloading https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 19:50:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 19:50:28 INFO - Downloaded 75602164 bytes. 19:50:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:50:28 INFO - mkdir: /builds/slave/test/properties 19:50:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:50:28 INFO - Writing to file /builds/slave/test/properties/build_url 19:50:28 INFO - Contents: 19:50:28 INFO - build_url:https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:50:29 INFO - Running post-action listener: _resource_record_post_action 19:50:29 INFO - Running post-action listener: set_extra_try_arguments 19:50:29 INFO - [mozharness: 2017-03-26 02:50:29.685626Z] Finished download-and-extract step (success) 19:50:29 INFO - [mozharness: 2017-03-26 02:50:29.685762Z] Running populate-webroot step. 19:50:29 INFO - Running pre-action listener: _resource_record_pre_action 19:50:29 INFO - Running main action method: populate_webroot 19:50:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:50:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:50:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:50:29 INFO - '--tppagecycles', 19:50:29 INFO - '7'], 19:50:29 INFO - 'tests': ['tsvgm']}}, 19:50:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:50:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:50:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:50:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:50:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:50:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:50:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:50:29 INFO - 'talos_options': ['--disable-e10s'], 19:50:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:50:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:50:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:50:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:50:29 INFO - 'talos_options': ['--disable-e10s'], 19:50:29 INFO - 'tests': ['damp', 'tps']}, 19:50:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:50:29 INFO - 'tests': ['damp', 'tps']}, 19:50:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:50:29 INFO - 'tests': ['dromaeo_dom']}, 19:50:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:50:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:50:29 INFO - 'tests': ['basic_compositor_video']}, 19:50:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:50:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:50:29 INFO - 'tests': ['a11yr', 19:50:29 INFO - 'ts_paint', 19:50:29 INFO - 'tpaint', 19:50:29 INFO - 'sessionrestore', 19:50:29 INFO - 'sessionrestore_no_auto_restore', 19:50:29 INFO - 'tabpaint']}, 19:50:29 INFO - 'other-e10s': {'tests': ['a11yr', 19:50:29 INFO - 'ts_paint', 19:50:29 INFO - 'tpaint', 19:50:29 INFO - 'sessionrestore', 19:50:29 INFO - 'sessionrestore_no_auto_restore', 19:50:29 INFO - 'tabpaint']}, 19:50:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:50:29 INFO - 'ts_paint', 19:50:29 INFO - 'tpaint', 19:50:29 INFO - 'sessionrestore', 19:50:29 INFO - 'sessionrestore_no_auto_restore', 19:50:29 INFO - 'tabpaint']}, 19:50:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:50:29 INFO - 'ts_paint', 19:50:29 INFO - 'tpaint', 19:50:29 INFO - 'sessionrestore', 19:50:29 INFO - 'sessionrestore_no_auto_restore', 19:50:29 INFO - 'tabpaint']}, 19:50:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:50:29 INFO - 'tests': ['a11yr', 19:50:29 INFO - 'ts_paint', 19:50:29 INFO - 'tpaint', 19:50:29 INFO - 'sessionrestore', 19:50:29 INFO - 'sessionrestore_no_auto_restore', 19:50:29 INFO - 'tabpaint']}, 19:50:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:50:29 INFO - 'tests': ['a11yr', 19:50:29 INFO - 'ts_paint', 19:50:29 INFO - 'tpaint', 19:50:29 INFO - 'sessionrestore', 19:50:29 INFO - 'sessionrestore_no_auto_restore', 19:50:29 INFO - 'tabpaint']}, 19:50:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:50:29 INFO - 'tests': ['tsvgx', 19:50:29 INFO - 'tsvgr_opacity', 19:50:29 INFO - 'tart', 19:50:29 INFO - 'tscrollx', 19:50:29 INFO - 'cart', 19:50:29 INFO - 'tsvg_static']}, 19:50:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:50:29 INFO - 'tsvgr_opacity', 19:50:29 INFO - 'tart', 19:50:29 INFO - 'tscrollx', 19:50:29 INFO - 'cart', 19:50:29 INFO - 'tsvg_static']}, 19:50:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:50:29 INFO - 'talos_options': ['--disable-e10s'], 19:50:29 INFO - 'tests': ['tp5o']}, 19:50:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:50:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:50:29 INFO - 'talos_options': ['--disable-e10s', 19:50:29 INFO - '--xperf_path', 19:50:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:50:29 INFO - 'tests': ['tp5n']}, 19:50:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:50:29 INFO - 'talos_options': ['--xperf_path', 19:50:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:50:29 INFO - 'tests': ['tp5n']}}, 19:50:29 INFO - 'talos.zip': {'path': '', 19:50:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:50:29 INFO - Running post-action listener: _resource_record_post_action 19:50:29 INFO - [mozharness: 2017-03-26 02:50:29.704280Z] Finished populate-webroot step (success) 19:50:29 INFO - [mozharness: 2017-03-26 02:50:29.704408Z] Running create-virtualenv step. 19:50:29 INFO - Running pre-action listener: _resource_record_pre_action 19:50:29 INFO - Running main action method: create_virtualenv 19:50:29 INFO - Creating virtualenv /builds/slave/test/build/venv 19:50:29 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 19:50:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:50:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:50:29 INFO - Using real prefix '/tools/python27' 19:50:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:50:30 INFO - Installing distribute.............................................................................................................................................................................................done. 19:50:33 INFO - Installing pip.................done. 19:50:33 INFO - Return code: 0 19:50:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:50:33 INFO - Reading from file tmpfile_stdout 19:50:33 INFO - Output received: 19:50:33 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) 19:50:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10890db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d3d61920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086ebd30>, '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 0x108612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086e0be8>, '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.nXjTCtrAY8/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.zfluheiGEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 19:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:50:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXjTCtrAY8/Render', 19:50:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:33 INFO - 'HOME': '/Users/cltbld', 19:50:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:33 INFO - 'LOGNAME': 'cltbld', 19:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:33 INFO - 'MOZ_NO_REMOTE': '1', 19:50:33 INFO - 'NO_EM_RESTART': '1', 19:50:33 INFO - 'PAGER': '/bin/cat', 19:50:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:33 INFO - 'PWD': '/builds/slave/test', 19:50:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:33 INFO - 'SHELL': '/bin/bash', 19:50:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zfluheiGEo/Listeners', 19:50:33 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 19:50:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:33 INFO - 'USER': 'cltbld', 19:50:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:33 INFO - 'XPC_FLAGS': '0x0', 19:50:33 INFO - 'XPC_SERVICE_NAME': '0', 19:50:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:33 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 19:50:33 INFO - Cleaning up... 19:50:33 INFO - Return code: 0 19:50:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10890db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d3d61920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086ebd30>, '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 0x108612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086e0be8>, '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.nXjTCtrAY8/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.zfluheiGEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 19:50:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:50:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXjTCtrAY8/Render', 19:50:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:33 INFO - 'HOME': '/Users/cltbld', 19:50:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:33 INFO - 'LOGNAME': 'cltbld', 19:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:33 INFO - 'MOZ_NO_REMOTE': '1', 19:50:33 INFO - 'NO_EM_RESTART': '1', 19:50:33 INFO - 'PAGER': '/bin/cat', 19:50:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:33 INFO - 'PWD': '/builds/slave/test', 19:50:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:33 INFO - 'SHELL': '/bin/bash', 19:50:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zfluheiGEo/Listeners', 19:50:33 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 19:50:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:33 INFO - 'USER': 'cltbld', 19:50:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:33 INFO - 'XPC_FLAGS': '0x0', 19:50:33 INFO - 'XPC_SERVICE_NAME': '0', 19:50:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:34 INFO - Downloading/unpacking psutil>=3.1.1 19:50:34 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 19:50:34 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 19:50:34 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 19:50:34 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 19:50:34 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 19:50:34 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 19:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:50:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:50:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:50:38 INFO - Installing collected packages: psutil 19:50:38 INFO - Running setup.py install for psutil 19:50:38 INFO - building 'psutil._psutil_osx' extension 19:50:38 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 19:50:38 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 19:50:38 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 19:50:39 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 19:50:39 INFO - building 'psutil._psutil_posix' extension 19:50:39 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 19:50:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:50:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:50:39 INFO - ^ 19:50:39 INFO - 1 warning generated. 19:50:39 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 19:50:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:50:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:50:39 INFO - Successfully installed psutil 19:50:39 INFO - Cleaning up... 19:50:39 INFO - Return code: 0 19:50:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:39 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 0x10890db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d3d61920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086ebd30>, '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 0x108612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086e0be8>, '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.nXjTCtrAY8/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.zfluheiGEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 19:50:39 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 19:50:39 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 19:50:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXjTCtrAY8/Render', 19:50:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:39 INFO - 'HOME': '/Users/cltbld', 19:50:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:39 INFO - 'LOGNAME': 'cltbld', 19:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:39 INFO - 'MOZ_NO_REMOTE': '1', 19:50:39 INFO - 'NO_EM_RESTART': '1', 19:50:39 INFO - 'PAGER': '/bin/cat', 19:50:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:39 INFO - 'PWD': '/builds/slave/test', 19:50:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:39 INFO - 'SHELL': '/bin/bash', 19:50:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zfluheiGEo/Listeners', 19:50:39 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 19:50:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:39 INFO - 'USER': 'cltbld', 19:50:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:39 INFO - 'XPC_FLAGS': '0x0', 19:50:39 INFO - 'XPC_SERVICE_NAME': '0', 19:50:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:50:39 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 19:50:39 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 19:50:39 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 19:50:39 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 19:50:39 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 19:50:39 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 19:50:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:50:42 INFO - Installing collected packages: mozsystemmonitor 19:50:42 INFO - Running setup.py install for mozsystemmonitor 19:50:42 INFO - Successfully installed mozsystemmonitor 19:50:42 INFO - Cleaning up... 19:50:42 INFO - Return code: 0 19:50:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:50:42 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')]} 19:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:42 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')]} 19:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:42 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 0x10890db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d3d61920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086ebd30>, '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 0x108612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086e0be8>, '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.nXjTCtrAY8/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.zfluheiGEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 19:50:42 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 19:50:42 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 19:50:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXjTCtrAY8/Render', 19:50:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:42 INFO - 'HOME': '/Users/cltbld', 19:50:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:42 INFO - 'LOGNAME': 'cltbld', 19:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:42 INFO - 'MOZ_NO_REMOTE': '1', 19:50:42 INFO - 'NO_EM_RESTART': '1', 19:50:42 INFO - 'PAGER': '/bin/cat', 19:50:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:42 INFO - 'PWD': '/builds/slave/test', 19:50:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:42 INFO - 'SHELL': '/bin/bash', 19:50:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zfluheiGEo/Listeners', 19:50:42 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 19:50:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:42 INFO - 'USER': 'cltbld', 19:50:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:42 INFO - 'XPC_FLAGS': '0x0', 19:50:42 INFO - 'XPC_SERVICE_NAME': '0', 19:50:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:42 INFO - Downloading/unpacking jsonschema==2.5.1 19:50:42 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 19:50:42 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 19:50:42 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 19:50:42 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 19:50:42 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 19:50:42 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 19:50:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:50:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:50:45 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 19:50:45 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 19:50:45 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 19:50:45 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 19:50:45 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 19:50:45 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 19:50:45 INFO - Downloading functools32-3.2.3-2.tar.gz 19:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:50:46 INFO - warning: no files found matching '*.txt' 19:50:46 INFO - no previously-included directories found matching 'build' 19:50:46 INFO - no previously-included directories found matching 'dist' 19:50:46 INFO - no previously-included directories found matching '.git*' 19:50:46 INFO - Installing collected packages: jsonschema, functools32 19:50:46 INFO - Running setup.py install for functools32 19:50:46 INFO - warning: no files found matching '*.txt' 19:50:46 INFO - no previously-included directories found matching 'build' 19:50:46 INFO - no previously-included directories found matching 'dist' 19:50:46 INFO - no previously-included directories found matching '.git*' 19:50:46 INFO - Successfully installed jsonschema functools32 19:50:46 INFO - Cleaning up... 19:50:46 INFO - Return code: 0 19:50:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:46 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 0x10890db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d3d61920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086ebd30>, '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 0x108612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086e0be8>, '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.nXjTCtrAY8/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.zfluheiGEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 19:50:46 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 19:50:46 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 19:50:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXjTCtrAY8/Render', 19:50:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:46 INFO - 'HOME': '/Users/cltbld', 19:50:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:46 INFO - 'LOGNAME': 'cltbld', 19:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:46 INFO - 'MOZ_NO_REMOTE': '1', 19:50:46 INFO - 'NO_EM_RESTART': '1', 19:50:46 INFO - 'PAGER': '/bin/cat', 19:50:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:46 INFO - 'PWD': '/builds/slave/test', 19:50:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:46 INFO - 'SHELL': '/bin/bash', 19:50:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zfluheiGEo/Listeners', 19:50:46 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 19:50:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:46 INFO - 'USER': 'cltbld', 19:50:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:46 INFO - 'XPC_FLAGS': '0x0', 19:50:46 INFO - 'XPC_SERVICE_NAME': '0', 19:50:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:50:46 INFO - Cleaning up... 19:50:46 INFO - Return code: 0 19:50:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:46 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 0x10890db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d3d61920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086ebd30>, '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 0x108612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086e0be8>, '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.nXjTCtrAY8/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.zfluheiGEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 19:50:46 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 19:50:46 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 19:50:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXjTCtrAY8/Render', 19:50:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:46 INFO - 'HOME': '/Users/cltbld', 19:50:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:46 INFO - 'LOGNAME': 'cltbld', 19:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:46 INFO - 'MOZ_NO_REMOTE': '1', 19:50:46 INFO - 'NO_EM_RESTART': '1', 19:50:46 INFO - 'PAGER': '/bin/cat', 19:50:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:46 INFO - 'PWD': '/builds/slave/test', 19:50:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:46 INFO - 'SHELL': '/bin/bash', 19:50:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zfluheiGEo/Listeners', 19:50:46 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 19:50:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:46 INFO - 'USER': 'cltbld', 19:50:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:46 INFO - 'XPC_FLAGS': '0x0', 19:50:46 INFO - 'XPC_SERVICE_NAME': '0', 19:50:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:46 INFO - Downloading/unpacking blobuploader==1.2.4 19:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:49 INFO - Downloading blobuploader-1.2.4.tar.gz 19:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:50:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:50:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:50 INFO - Downloading docopt-0.6.1.tar.gz 19:50:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:50:50 INFO - Installing collected packages: blobuploader, requests, docopt 19:50:50 INFO - Running setup.py install for blobuploader 19:50:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:50:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:50:50 INFO - Running setup.py install for requests 19:50:51 INFO - Running setup.py install for docopt 19:50:51 INFO - Successfully installed blobuploader requests docopt 19:50:51 INFO - Cleaning up... 19:50:51 INFO - Return code: 0 19:50:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:50:51 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')]} 19:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:51 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')]} 19:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:51 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 0x10890db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d3d61920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086ebd30>, '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 0x108612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086e0be8>, '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.nXjTCtrAY8/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.zfluheiGEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 19:50:51 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 19:50:51 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 19:50:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXjTCtrAY8/Render', 19:50:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:51 INFO - 'HOME': '/Users/cltbld', 19:50:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:51 INFO - 'LOGNAME': 'cltbld', 19:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:51 INFO - 'MOZ_NO_REMOTE': '1', 19:50:51 INFO - 'NO_EM_RESTART': '1', 19:50:51 INFO - 'PAGER': '/bin/cat', 19:50:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:51 INFO - 'PWD': '/builds/slave/test', 19:50:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:51 INFO - 'SHELL': '/bin/bash', 19:50:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zfluheiGEo/Listeners', 19:50:51 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 19:50:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:51 INFO - 'USER': 'cltbld', 19:50:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:51 INFO - 'XPC_FLAGS': '0x0', 19:50:51 INFO - 'XPC_SERVICE_NAME': '0', 19:50:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:50:51 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-QTTnB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-zfJ0nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ZqFx5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-x9AtXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-NGAt9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-mGSCwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-CzJ346-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-uTG6NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0mozlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-BiAEx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-o2ZqFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-8vuXGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-5kNspD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-8VuBEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-IMTsmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-RhgCpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-O1fNNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:50:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:50:53 INFO - Running setup.py install for manifestparser 19:50:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:50:53 INFO - Running setup.py install for mozcrash 19:50:53 INFO - Running setup.py install for mozdebug 19:50:54 INFO - Running setup.py install for mozdevice 19:50:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:50:54 INFO - Running setup.py install for mozfile 19:50:54 INFO - Running setup.py install for mozhttpd 19:50:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:50:54 INFO - Running setup.py install for mozinfo 19:50:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:50:54 INFO - Running setup.py install for mozInstall 19:50:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:50:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:50:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:50:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:50:54 INFO - Running setup.py install for mozleak 19:50:54 INFO - Running setup.py install for mozlog 19:50:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:50:55 INFO - Running setup.py install for moznetwork 19:50:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:50:55 INFO - Running setup.py install for mozprocess 19:50:55 INFO - Running setup.py install for mozprofile 19:50:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:50:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:50:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:50:55 INFO - Running setup.py install for mozrunner 19:50:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:50:55 INFO - Running setup.py install for mozscreenshot 19:50:55 INFO - Running setup.py install for moztest 19:50:56 INFO - Running setup.py install for mozversion 19:50:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:50:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:50:56 INFO - Cleaning up... 19:50:56 INFO - Return code: 0 19:50:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:50: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')]} 19:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50: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')]} 19:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:56 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 0x10890db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d3d61920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086ebd30>, '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 0x108612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086e0be8>, '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.nXjTCtrAY8/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.zfluheiGEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 19:50:56 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 19:50:56 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 19:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXjTCtrAY8/Render', 19:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:56 INFO - 'HOME': '/Users/cltbld', 19:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:56 INFO - 'LOGNAME': 'cltbld', 19:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:56 INFO - 'MOZ_NO_REMOTE': '1', 19:50:56 INFO - 'NO_EM_RESTART': '1', 19:50:56 INFO - 'PAGER': '/bin/cat', 19:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:56 INFO - 'PWD': '/builds/slave/test', 19:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:56 INFO - 'SHELL': '/bin/bash', 19:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zfluheiGEo/Listeners', 19:50:56 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 19:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:56 INFO - 'USER': 'cltbld', 19:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:56 INFO - 'XPC_FLAGS': '0x0', 19:50:56 INFO - 'XPC_SERVICE_NAME': '0', 19:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:50:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-UhCETJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:50:56 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)) 19:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:50:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-uApbu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:50:56 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)) 19:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:50:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-8h38qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:50:56 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)) 19:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:50:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-gze4F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:50:56 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)) 19:50:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:50:56 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-MJgxPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:50:57 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)) 19:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:50:57 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-im0hMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:50:57 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)) 19:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:50:57 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-D3oyvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:50:57 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)) 19:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:50:57 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-jM7zaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:50:57 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)) 19:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:50:57 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ZbtPpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:50:57 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)) 19:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:50:57 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0xlE72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:50:57 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)) 19:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:50:57 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cdFLFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:50:57 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)) 19:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:50:57 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cHqCfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 19:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:50:57 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-FUiHCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:50:57 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)) 19:50:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:50:57 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-_VwanC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:50:58 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)) 19:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:58 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ti9BA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:58 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)) 19:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:50:58 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-fVXKII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:50:58 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)) 19:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:50:58 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-GTZz8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:50:58 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)) 19:50:58 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)) 19:50:58 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)) 19:50:58 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)) 19:50:58 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)) 19:50:58 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)) 19:50:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:50:58 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 19:50:58 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 19:50:58 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 19:50:58 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 19:50:58 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 19:50:58 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 19:51:00 INFO - Downloading blessings-1.6.tar.gz 19:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:51:01 INFO - Installing collected packages: blessings 19:51:01 INFO - Running setup.py install for blessings 19:51:01 INFO - Successfully installed blessings 19:51:01 INFO - Cleaning up... 19:51:01 INFO - Return code: 0 19:51:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:51:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:01 INFO - Reading from file tmpfile_stdout 19:51:01 INFO - Current package versions: 19:51:01 INFO - blessings == 1.6 19:51:01 INFO - blobuploader == 1.2.4 19:51:01 INFO - docopt == 0.6.1 19:51:01 INFO - functools32 == 3.2.3-2 19:51:01 INFO - jsonschema == 2.5.1 19:51:01 INFO - manifestparser == 1.1 19:51:01 INFO - mozInstall == 1.12 19:51:01 INFO - mozcrash == 1.0 19:51:01 INFO - mozdebug == 0.1 19:51:01 INFO - mozdevice == 0.49 19:51:01 INFO - mozfile == 1.2 19:51:01 INFO - mozhttpd == 0.7 19:51:01 INFO - mozinfo == 0.9 19:51:01 INFO - mozleak == 0.1 19:51:01 INFO - mozlog == 3.4 19:51:01 INFO - moznetwork == 0.27 19:51:01 INFO - mozprocess == 0.25 19:51:01 INFO - mozprofile == 0.28 19:51:01 INFO - mozrunner == 6.13 19:51:01 INFO - mozscreenshot == 0.1 19:51:01 INFO - mozsystemmonitor == 0.3 19:51:01 INFO - moztest == 0.8 19:51:01 INFO - mozversion == 1.4 19:51:01 INFO - psutil == 3.1.1 19:51:01 INFO - requests == 1.2.3 19:51:01 INFO - wsgiref == 0.1.2 19:51:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51: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')]} 19:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:01 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 0x10890db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d3d61920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086ebd30>, '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 0x108612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086e0be8>, '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.nXjTCtrAY8/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.zfluheiGEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 19:51:01 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 19:51:01 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 19:51:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXjTCtrAY8/Render', 19:51:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:01 INFO - 'HOME': '/Users/cltbld', 19:51:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:01 INFO - 'LOGNAME': 'cltbld', 19:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:01 INFO - 'MOZ_NO_REMOTE': '1', 19:51:01 INFO - 'NO_EM_RESTART': '1', 19:51:01 INFO - 'PAGER': '/bin/cat', 19:51:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:01 INFO - 'PWD': '/builds/slave/test', 19:51:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:01 INFO - 'SHELL': '/bin/bash', 19:51:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zfluheiGEo/Listeners', 19:51:01 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 19:51:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:01 INFO - 'USER': 'cltbld', 19:51:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:01 INFO - 'XPC_FLAGS': '0x0', 19:51:01 INFO - 'XPC_SERVICE_NAME': '0', 19:51:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:01 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)) 19:51:01 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)) 19:51:01 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)) 19:51:01 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)) 19:51:01 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)) 19:51:01 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)) 19:51:01 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)) 19:51:01 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)) 19:51:01 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)) 19:51:01 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)) 19:51:01 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)) 19:51:01 INFO - Cleaning up... 19:51:01 INFO - Return code: 0 19:51:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:51: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')]} 19:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10890db70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9d3d61920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086ebd30>, '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 0x108612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086e0be8>, '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.nXjTCtrAY8/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.zfluheiGEo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 19:51: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', 'jsonschema'] in /builds/slave/test/build 19:51: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 jsonschema 19:51:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXjTCtrAY8/Render', 19:51:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:01 INFO - 'HOME': '/Users/cltbld', 19:51:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:01 INFO - 'LOGNAME': 'cltbld', 19:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:01 INFO - 'MOZ_NO_REMOTE': '1', 19:51:01 INFO - 'NO_EM_RESTART': '1', 19:51:01 INFO - 'PAGER': '/bin/cat', 19:51:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:01 INFO - 'PWD': '/builds/slave/test', 19:51:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:01 INFO - 'SHELL': '/bin/bash', 19:51:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zfluheiGEo/Listeners', 19:51:01 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 19:51:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:01 INFO - 'USER': 'cltbld', 19:51:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:01 INFO - 'XPC_FLAGS': '0x0', 19:51:01 INFO - 'XPC_SERVICE_NAME': '0', 19:51:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:51:02 INFO - Cleaning up... 19:51:02 INFO - Return code: 0 19:51:02 INFO - Running post-action listener: _resource_record_post_action 19:51:02 INFO - Running post-action listener: _start_resource_monitoring 19:51:02 INFO - Starting resource monitoring. 19:51:02 INFO - [mozharness: 2017-03-26 02:51:02.170269Z] Finished create-virtualenv step (success) 19:51:02 INFO - [mozharness: 2017-03-26 02:51:02.171222Z] Running install step. 19:51:02 INFO - Running pre-action listener: _resource_record_pre_action 19:51:02 INFO - Running main action method: install 19:51:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:02 INFO - Reading from file tmpfile_stdout 19:51:02 INFO - Detecting whether we're running mozinstall >=1.0... 19:51:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:51:02 INFO - Reading from file tmpfile_stdout 19:51:02 INFO - Output received: 19:51:02 INFO - Usage: mozinstall [options] installer 19:51:02 INFO - Options: 19:51:02 INFO - -h, --help show this help message and exit 19:51:02 INFO - -d DEST, --destination=DEST 19:51:02 INFO - Directory to install application into. [default: 19:51:02 INFO - "/builds/slave/test"] 19:51:02 INFO - --app=APP Application being installed. [default: firefox] 19:51:02 INFO - mkdir: /builds/slave/test/build/application 19:51:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:51:22 INFO - Reading from file tmpfile_stdout 19:51:22 INFO - Output received: 19:51:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:51:22 INFO - Running post-action listener: _resource_record_post_action 19:51:22 INFO - [mozharness: 2017-03-26 02:51:22.881579Z] Finished install step (success) 19:51:22 INFO - [mozharness: 2017-03-26 02:51:22.881681Z] Running run-tests step. 19:51:22 INFO - Running pre-action listener: _resource_record_pre_action 19:51:22 INFO - Running main action method: run_tests 19:51:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:51:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:51:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:51:22 INFO - 2017-03-25 19:51:22.896 screenresolution[1634:8387] starting screenresolution argv=screenresolution get 19:51:22 INFO - 2017-03-25 19:51:22.899 screenresolution[1634:8387] Display 0: 1600x1200x32@60 19:51:22 INFO - 2017-03-25 19:51:22.905 screenresolution[1635:8390] starting screenresolution argv=screenresolution list 19:51:22 INFO - Available Modes on Display 0 19:51:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:51:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:51:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:51:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:51:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:51:23 INFO - Intel Iris: 19:51:23 INFO - Chipset Model: Intel Iris 19:51:23 INFO - Type: GPU 19:51:23 INFO - Bus: Built-In 19:51:23 INFO - VRAM (Dynamic, Max): 1536 MB 19:51:23 INFO - Vendor: Intel (0x8086) 19:51:23 INFO - Device ID: 0x0a2e 19:51:23 INFO - Revision ID: 0x0009 19:51:23 INFO - Displays: 19:51:23 INFO - Display: 19:51:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:51:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:51:23 INFO - Display Serial Number: 1600x1200 60 19:51:23 INFO - Main Display: Yes 19:51:23 INFO - Mirror: Off 19:51:23 INFO - Online: Yes 19:51:23 INFO - Rotation: Supported 19:51:23 INFO - Return code: 0 19:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:51:23 INFO - Python 2.7.3 19:51:23 INFO - Return code: 0 19:51:23 INFO - grabbing minidump binary from tooltool 19:51: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')]} 19:51:23 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 0x1086ebd30>, '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 0x108612db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086e0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:51:23 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 19:51:23 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 19:51:23 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 19:51:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:51:23 INFO - Return code: 0 19:51:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:51:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:51:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:51:23 INFO - ENV: RUST_BACKTRACE is now 1 19:51:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:51:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:51:23 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/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 19:51:23 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/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --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 19:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nXjTCtrAY8/Render', 19:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:23 INFO - 'HOME': '/Users/cltbld', 19:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:23 INFO - 'LOGNAME': 'cltbld', 19:51:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:51:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:23 INFO - 'MOZ_NO_REMOTE': '1', 19:51:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:51:23 INFO - 'NO_EM_RESTART': '1', 19:51:23 INFO - 'PAGER': '/bin/cat', 19:51:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:23 INFO - 'PWD': '/builds/slave/test', 19:51:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:23 INFO - 'RUST_BACKTRACE': '1', 19:51:23 INFO - 'SHELL': '/bin/bash', 19:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zfluheiGEo/Listeners', 19:51:23 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 19:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:23 INFO - 'USER': 'cltbld', 19:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:23 INFO - 'XPC_FLAGS': '0x0', 19:51:23 INFO - 'XPC_SERVICE_NAME': '0', 19:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:23 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/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 19:51:23 INFO - mozversion application_buildid: 20170325184016 19:51:23 INFO - mozversion application_changeset: f5e214144799889e2408c4841351f4053f00544e 19:51:23 INFO - mozversion application_display_name: Nightly 19:51:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:51:23 INFO - mozversion application_name: Firefox 19:51:23 INFO - mozversion application_remotingname: firefox 19:51:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:51:23 INFO - mozversion application_vendor: Mozilla 19:51:23 INFO - mozversion application_version: 55.0a1 19:51:23 INFO - mozversion platform_buildid: 20170325184016 19:51:23 INFO - mozversion platform_changeset: f5e214144799889e2408c4841351f4053f00544e 19:51:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:51:23 INFO - mozversion platform_version: 55.0a1 19:51:23 INFO - using testdate: 1490496683 19:51:23 INFO - actual date: 1490496683 19:51:23 INFO - starting webserver on 'localhost:49249' 19:51:23 INFO - SUITE-START | Running 2 tests 19:51:23 INFO - TEST-START | dromaeo_css 19:51:23 INFO - operating with platform_type : mac_ 19:51:23 INFO - Initialising browser for dromaeo_css test... 19:51:23 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpj2iLhF/profile http://localhost:49249/getInfo.html) 19:51:26 INFO - PID 1645 | __metrics Screen width/height:1600/1200 19:51:26 INFO - PID 1645 | colorDepth:24 19:51:26 INFO - PID 1645 | Browser inner width/height: 1024/689 19:51:26 INFO - PID 1645 | __metrics 19:51:26 ERROR - PID 1645 | 1490496686200 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 19:51:26 INFO - PID 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:51:26 INFO - PID 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:51:27 INFO - TEST-INFO | 1645: exit 0 19:51:27 INFO - Browser initialized. 19:51:27 INFO - Running cycle 1/1 for dromaeo_css test... 19:51:27 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpj2iLhF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:51:39 INFO - PID 1648 | RSS: Main: 233824256 19:51:39 INFO - PID 1648 | 19:54:44 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 19:54:46 INFO - PID 1648 | RSS: Main: 357888000 19:54:46 INFO - PID 1648 | 19:56:29 INFO - PID 1648 | ************************* 19:56:29 INFO - PID 1648 | A coding exception was thrown and uncaught in a Task. 19:56:29 INFO - PID 1648 | 19:56:29 ERROR - PID 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:56:29 INFO - PID 1648 | Full stack: 19:56:29 INFO - PID 1648 | ************************* 19:56:29 INFO - PID 1648 | ************************* 19:56:29 INFO - PID 1648 | A coding exception was thrown and uncaught in a Task. 19:56:29 INFO - PID 1648 | 19:56:29 ERROR - PID 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:56:29 INFO - PID 1648 | Full stack: 19:56:29 INFO - PID 1648 | ************************* 19:56:29 INFO - PID 1648 | ************************* 19:56:29 INFO - PID 1648 | A coding exception was thrown and uncaught in a Task. 19:56:29 INFO - PID 1648 | 19:56:29 ERROR - PID 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:56:29 INFO - PID 1648 | Full stack: 19:56:29 INFO - PID 1648 | ************************* 19:56:29 INFO - PID 1648 | ************************* 19:56:29 INFO - PID 1648 | A coding exception was thrown and uncaught in a Task. 19:56:29 INFO - PID 1648 | 19:56:29 ERROR - PID 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:56:29 INFO - PID 1648 | Full stack: 19:56:29 INFO - PID 1648 | ************************* 19:57:49 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 19:57:49 INFO - PID 1648 | RSS: Main: 367366144 19:57:49 INFO - PID 1648 | 20:00:52 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 20:00:52 INFO - PID 1648 | RSS: Main: 338075648 20:00:52 INFO - PID 1648 | 20:03:55 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 20:03:55 INFO - PID 1648 | RSS: Main: 335642624 20:03:55 INFO - PID 1648 | 20:06:59 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 20:07:00 INFO - PID 1648 | RSS: Main: 343699456 20:07:00 INFO - PID 1648 | 20:10:03 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 20:10:03 INFO - PID 1648 | RSS: Main: 555388928 20:10:03 INFO - PID 1648 | 20:10:03 INFO - PID 1648 | __start_tp_report 20:10:03 INFO - PID 1648 | _x_x_mozilla_page_load 20:10:03 INFO - PID 1648 | _x_x_mozilla_page_load_details 20:10:03 INFO - PID 1648 | |i|pagename|runs| 20:10:03 INFO - PID 1648 | |0;dojo.html;3455.2571197192606;3470.652934706531;3475.9304813903723;3514.139035936196;3527.770694904831;5113.207452844806;6098.371716891083;6215.91221536231;6216.813495595128;6238.750449982001;6142.3550527194675;6154.446099851012;6159.260888693352;6169.629822210671;6190;4994.400671919375;5270.446603106676;5487.451254874501;5493.587980901429;5656.151577263402;5368.3021207243;5443.8094666686675;5542.251796007527;5575.219469274305;5618.044932361488;5461.972690136564;5525.557955363602;5548.611597188198;5610.607257491977;5624.21261023457;5481.506664400223;5514.062609356379;5515.61390702651;5517.420670829585;5544.140658197985;5490.890182196334;5514.696691681956;5521.834344969617;5544.556435485151;5546.611737178399;6053.303870054956;6089.665068421235;6109.877802443971;6122.510199184055;6133.233345831771;6395.616263024233;6406.199225096863;6408.583442076297;6413.647249401281;6473.320301368382;5574.637648552831;6556.409923106896;6582.9670851645915;6633.005049242604;6639.302873198341;6272.341404152589;6272.874542509125;6279.277883043463;6288.87422251557;6296.0555916612875;6525.3800888915475;6611.140551728245;6777.9661101695165;6778.457723382117;6789.490788190906;6321.810345689637;6359.872802543923;6367.522435817332;6373.203349581302;6380.649064301415;6413.102165696806;6429.935700643027;6536.57512261711;6618.238902526175;6638.037484564711;6456.741730330828;6478.1578394808375;6494.6103233806125;6508.60948343101;6518.543701940914;6540.37866402691;6550.181227346582;6562.278149403562;6565.343465653396;6573.244076931119;5157.200633901752;5223.4515375884985;5224.399194092652;5290.867728306823;5313.867153321121;4644.233701439292;4650.116477869194;4697.107549565571;4734.692245004133;4751.477337492873;6116.0010150213275;6127.34224287047;6203.751849926042;6226.906596401058;6231;6618.53670243088;6621.635810030398;6631.767888123893;6637.070810086591;6648.202215734143;6070.2412198475195;6224.004159334485;6227.875442491125;6231.688415579203;6247.968760156261;5659.151127330851;5661.179129026268;5705.942940570624;5721.5136713379;5743.224664670216;6700.229473610597;6754.358335958076;6758.729650814011;6761.864762704817;6774.695138718868;6608.140941677551;6608.900866486911;6608.966955165193;6617.8014659560295;6629.900551491828;6492.35076492347;6565.80302590923;6694.899576506259;6736.360045795642;6747.122874026345;6463.289038205699;6488.578242414228;6490.091387205701;6493.123428337114;6512.05575191604;6352.587081839665;6513.934860651333;6558.409743122951;6577.046328282277;6577.2436169841085;6238.251409830849;6289.496840252677;6318.368163183645;6390.329015453311;6391.616503009835;6345.302016778059;6410.134631824644;6411.871762564816;6423.614583125028;6441.710123044568;6195.659238741732;6278.8430289241305;6314.084457753692;6328.303886572566;6338.809835704937;5449.891002180014;6225.844353891189;6306.590071645328;6433.903491447539;6434.774782882577;6191.84520386994;6319.210098737658;6324.494040476843;6327.11420401135;6332.683365831782 20:10:03 INFO - PID 1648 | |1;ext.html;756.8561973225087;776.9494982826116;798.7643645124685;1128.554221082673;1151.7466157445358;27168;36049.63950360496;36473;36486.81756591217;36572;37394.626053739456;37623.24753504935;37668.811655941754;37712.05719857005;37723;8429.915700843005;8606.182412670787;8609.39734218605;8622.223999840013;8632.741017769476;6086.3913608639;6237.251529816428;6239.812805615838;6240.812775616739;6248.2814476335125;6196.597221180631;8407.747767566983;8554.914450855505;8569.614367353453;8574.78563035926;8545.23092921637;8605.354598405082;8610.698625548075;8617.396782225183;8617.61220745068;8473.110323416076;8528.445651032725;8560.914390856075;8564.272036876873;8565.657373705044;36444.817775911215;36740;38227.853164404834;38271.42592861109;38332.80833595842;2921.6932222116584;2983.3734915667737;2992.1771512833925;2997.341307759727;3034.6055012848187;20587.794122058738;26249;26383.604245936327;26753.86623066892;27046.32384190391;2760.9585856212175;2763.322985868455;2764.585312203186;2766.3222510484857;2770.0997175917705;288431;306522;308067;308643.99999999773;309081;48366;48434;48511.27233091507;48556.5144348552;48565;50607.49392506101;50649;50662.493375066515;50719.74640126776;50854.74572627113;14282.000259981909;14556.344964476624;14572.708545829237;14584.052036617586;14594.34325455357;11824.172307938534;11824.704382390337;11831.822522662167;11849;11866.703332416759;11405.429728513707;11591.594294199831;13382.464701411835;13726.45094196221;13757.587272381845;4805.609478218808;5641.943580564224;5764.567657425626;5774.162746401748;5777.971110144506;934.2525979216599;957.2198658093631;981.896900825403;982.2142286171035;1003.19744204636;27944.301392464946;28144.29639258994;28746.568801467994;28790.42419151647;28826.855865720536;1050.6217761605815;1053.6733612580124;1093.8742044664966;1105.7401510644993;1110.2006555280186;11482.125372179918;11492.885071149349;12091;12162.027037836951;12190.512379504898;384059;447240;448529;450162;450297;52580.737096314275;52846.73576632169;52948;53040;53045.93908121893;1409.1122592766492;1460.7540434248397;1481.3482067890093;1482.8072350594355;1496.7006598680307;23319.883400582887;23338.18316358987;23341.299761007198;23391.298261052194;23467.295981120595;37619.247615048094;37846;37880.999999998894;37883.242335152594;37951.81024094862;446079;450997.4900250955;451487.74256129825;453336;453387.4661253477;27075;32278;33666.83166584151;33823.4926476108;33870.153246169044;41176.794116029225;41283.96790080272;41441.58558414377;41759.7912010438;42471;27904.44191116207;27954.720452795213;28138.71861281361;28882.133535993955;29383;28918.7108128916;29291.267718307212;29585.408291834472;30020.84989575038;30300.24249393783;35488.64511354853;36531.63468365389;36570.085747856516;36597;36650.8167459161;29141.417171656023;30017;31075.37849243048;31076.844615776776;31118;20634;23951.401214969766;24109.15617953363;24245.085320826125;24347.14784982588 20:10:03 INFO - PID 1648 | |2;jquery.html;353.12777439723874;362.9891103266902;421.2606874934489;432.27378004951686;447.67990886516156;12657.746845063093;14673;14754;20670.27654032109;21080.578388432223;18950.431487055375;19877.801221987775;22442.214522491715;22988.88505557474;23374.883125584347;5904.202932604107;6131.816045518631;6161.630302181861;6346.555741098125;6361;5412.5940554458375;6093.750781089866;6139;6151.138840562325;6155.322914479426;3649.671529562339;3947.8223479943326;4028.738132021424;6116.266048074237;6334.904976425358;6306.990881458967;6309.495240380758;6311.7475300988135;6317.463015643676;6328.873422531569;5362.276092727471;5370.275012873251;5418.106012507931;5420.620556561043;5424.484673956007;26838.46323073547;27194.45611087787;27381.904723811025;27728.02951896694;28014.019509317077;1950.9122089506006;1955.4817973237105;1970.162680860643;1974.9506262343557;2001.4596059063972;15129.621759455991;15857.60355991098;16202.027878327339;16519;16632.83367166325;1655.337864854056;1667.391402138223;1667.8999260044436;1688.7889013873266;1711.2384988680042;128561;135652.3217383907;156824;159025.20487397604;161549;12050.035997120209;12147.453364598614;12247.693807654701;12345.691357715948;12880.291583962971;16533.91733041327;16615.00309981405;16615.335386584644;16622.75065874013;16639.001659900445;8608.569571521399;8987.41581797181;9005.369624126379;9104.226140778108;9147.496887671108;8570.614322355508;8595.957020214859;8620.396572240008;8768.693095741619;8794.824103517894;6973.93026069743;7171.569705817667;7753.263439973193;7774.727884524128;7808.726694565663;2062.113291284732;2076.2421716073827;2077.6364136276393;2081.708560801489;2263.807576355995;744.4565467208968;850.9872351914727;863.9395242332977;881.2245224202661;918.3525614441802;18214.271429142686;20517.79482205189;20664.380068597966;20714.689279660815;21150.47123821917;883.5317281840635;926.8470702334039;953.5137080089204;954.5752140297501;966.3477152921749;9060.184583387527;10386.169106471463;10620.628278010232;10640.787184256425;10718.839217411745;530902;540381;542031;542212;542655;133302;150281;153675.46324536836;164186;165348;1183.680406290314;1223.8347823043953;1241.8013117901091;1242.7079636285466;1252.6116903759864;20756;21692.132314707866;21991.120355185612;22020.867927333882;22276.66585001259;64625;64943.67528162329;65278.673606631666;65756.34243657503;65803;76288;91307;93437.5328123355;94856;94860;7215.891761623475;7377.704891804267;7953.244441778022;8583.527905965231;9135.497547634945;14151.858481415466;14155.929220354245;14382.568522944328;14569;14629.487967921072;11596.246243994114;11776.941115294369;12145.574904878287;12184.20802647825;12201.816972745593;9850.507474626384;10755.784884302426;10985.395803230898;11264;11540.961313481826;11894.940525297665;11951.880481195076;12028.27830330183;12202;12333.814992775295;8735.91264087351;8857.689980850639;8925.687600933936;8997.820043599222;9020.73709680632;9948.751281218027;10140.695779126638;10163.593456261668;10543.736406589896;10672.30630009047 20:10:03 INFO - PID 1648 | |3;mootools.html;1259.5213818748873;1393.6097892590078;1417.801507788909;1422.224887436347;1428.093160842865;10416.947915260422;10835.729106772325;10852.891471085286;10855.620053298137;10859.13126949844;10479.109275711573;10918.07196388308;10923.453827308642;10935.234533582652;10951.780964380707;2409.975900240997;2467.0748469324003;2470.0119952019245;2472.0235506974823;2477.7398373170827;2043.5299881027372;2333.604682715042;2411.3489357873364;2466.7779899809016;2467.5558399488086;2090.0072465578883;2118.120979793384;2368.4197371643972;2456.2140115163156;2462.692163479565;2417.9153729619466;2419.4314336130997;2423.8303318767694;2425.599776036943;2431.8784060797066;2383.5232953409386;2416.32342943976;2416.4683769570665;2418.576749068906;2418.5888398972215;10892.782144357148;11130;11132.944335278271;11150.944245278723;11158.553657853676;6120.785772497941;6350.079238510436;6353.777617783356;6361.427471527539;6363.077353783676;3647.74465787395;3776.5845756966987;3817.2365526894455;3851.826667799956;3853.7109716771356;1132.4677401621307;1172.302480024384;1204;1205.1021988618536;1217.8660347361783;15446.150461724601;15533.378664853391;15622.218889055388;15624.296906639229;15626.45307414235;4444.400005999149;5056.595472362203;5251.396089449686;5392;5412.323459567554;11586.88413115875;11618.94190529042;11621;11637.88362116385;11684;6283.2460104787715;6286.685665716695;6300.30696623371;6301.338359472189;6304.653244071528;5654.6889921054735;5787.768489260467;5852.882942341129;5907.881842363128;5924.022536281465;3827.445020472016;3949.763014219156;3973.165635216637;4011.0947300032253;4037.7577345359373;1248.7065539598186;1254.3665448948223;1257.905657075723;1268.9569792633852;1272.0904553244475;562.9978638024323;669.4309836638915;750.4446709434978;757.5379018798528;797.123164519036;6392.264889537762;6492.67536623167;6546.70539825709;6646.069550262967;6700.731970721116;553.195101127858;594.6402426531886;595.8004068637055;596.8537708261504;690.9723611055603;3783;4095.3037983542868;4118.258713431611;4175.791210439465;4364.061726728705;13383;14210.934179936547;14221;14229.64425889361;14260.500882469063;10739.946300268604;14056.648583785487;14244.572662820132;14261.85738142626;14309;8054.315383192377;10189.23580731448;10208.234382421348;10208.591656333663;10214.948925255178;5718.456746609066;6078.939210607838;6527.934720652733;6865.965670171817;6927.618980956096;11974.820377694168;12527.749445011232;12545.498180072695;12567.24058631774;12594.748105038032;12176.33030183313;12517.56188533397;12547.874521254671;12602.684932876384;12664.493420263087;7598.506097103892;9143.954280228556;9368.906310936803;9386.108319709616;9388.389754665925;9840.753981150528;10175;10308.793824123326;10337.431441270803;10398.740031499274;8574.442661227;8590.441621294596;8670.523121228141;8801.91198088011;8802.031776504708;8414.326853851555;8485.57572121379;8552.187542183483;8594.183552562497;8641.611127499153;7585.886211706718;7817.609119543887;7857.646405911633;7910.485818421784;7970.4819186752675;4865.610751139971;5701.857453563694;5886.676232807236;5911.556633252438;6086.969565152146;5337.279467271868;5821.214136091743;5873.148393482836;6050.636961782131;6250.499960003098 20:10:03 INFO - PID 1648 | |4;prototype.html;389.43337444018954;394.29421335808905;394.4458036458776;401.8874715079777;404.84615845978544;4655.650826188037;4967.230079337708;6003.639781613107;6033.48715359195;6134.631922084678;5063.594912406998;5722.227499287595;5905.379935106816;5939.584229103964;5944.88110237795;3476.3394954958476;4417.359482874997;4534.79593418297;4683.601893839011;4693.694909830867;4513.1876262272945;4522.851645468392;4550.976030393168;4551.863444096666;4574.862754117382;3612.9638703613023;4435.201663700533;4495.842645507408;4535.138323718499;4552.201880257297;3512.666296701809;3931.331673615492;4480.507144214133;4523;4552.408186935694;3533.6643018913164;3693.8549049794383;3834.328992426342;3879.2047630236016;3895;4805.975970120162;5302.0425901781955;5450.672959622396;5844.707764611795;5893.410658934115;4378.255696531597;4474.373587697725;5043.722595257259;5245.344331958505;5248.501392367719;6292.937070629281;6344.619322840645;6363.522735794834;6366.872662546723;6370.713317900706;4275.5296917339065;4289.313709806447;4292.635126014293;4296.9140617187795;4307.707687693679;6062.969685151546;6331.493480521547;6419.422251997296;6614.5039122065555;6654.10169627099;3987.491007913076;4064.451299074587;4329.870103896888;4338.8047537860875;4354.586314300136;3726.9440958385103;4390;4405;4425.22558552252;4450.799714012877;4501.527339629357;5120.897582048413;5188.81839135636;5190.935858149071;5219.347581552306;5233.633645644768;5952.779680165556;6291.339409362043;6340.207474065742;6354.078658594478;1298.8506321772927;1495.6559991202084;1518.0436325115106;1521.0949485056374;1531.1808182622244;937.3063932689761;994.8607194992707;998.8351921932945;1002.5588740953957;1015.4821041268858;5226.268322434862;5950.018246989198;5950.732217050157;5988.251468566429;5990.520758339322;6628.933710662832;6685.866282674319;6704.899426508607;6712.765053223114;6716.5634233774645;4604.723716577016;4942.702491832099;5889.882202355929;5904.494353939718;5984.880302393928;3437.5015622734563;3486.163320802989;3495.475678648172;3501.702355299777;3504.5444092267844;5318.0081929544485;6034.9094763577705;6306.653134077578;6782.93217067823;6830.795076147723;6503;6737.797866064026;6831.838587440147;6846.212685541127;6850.45196384298;5640.915386269127;5771.249737534094;6621;6632.701528431232;6638.5684930479365;5850.882982340244;6553.574017688835;6575.63833989116;6670.599764014175;6713.63075030878;6268.843278918063;6553.082568440517;6561.359660084979;6583.938468612118;6598.360655737743;6754.3921047106;6758.459323254227;6765.797026089225;6815.556988795713;6837.897431538431;3818.2745278397015;3845.7309088001452;4135.8966025848395;4303.053328267776;4323.437953066082;6618.735250590115;6635.469162466895;6651.16860392451;6652.201735791736;6685.899711504234;5513.015314486702;6151.784687535915;6389.169407976933;6432.871342573028;6514.511411644051;6367.752446252352;6410.679466026587;6421.967890160519;6426.871462570816;6428.228612566522;5496.31296087989;6280.591761535486;6293.244810622755;6363.140975968185;6374.58565193261;5226.973865130803;5340.626156169186;5913.91129133072;6059.3334733178435;6428.100065990859;5386.757595908115;5509.807156749494;5939.287285525765;6150.10823430609;6269.655168965568 20:10:03 INFO - PID 1648 | |5;yui.html;646.9644169570674;712.1952194020756;727.8034930568747;731.4696844787529;735.2610626320547;13462.394192261347;14207.289635518222;15253.237338133076;15880.523584292461;15893.920530397347;14213.857861421382;14698;14881.25593720315;15067.849321506808;15137.621559461018;784.2588753627824;948.0045951750669;951.2675240065146;953.2945620241042;953.7806304549957;916.0564618443015;944.4569372610742;949.6343907595591;960.7213907966682;961.2502248246379;973.8928717841031;976.7899901521172;979.1139019187647;980.2109302011878;980.4852452462443;975.1662328708993;976.6679329028093;977.2914636888306;978.0561757903586;978.7895602445473;723.1286300008529;723.706898706025;725.4414101142091;725.4631572636264;725.7568714480656;13655.658608534766;15812.209389530477;16400.75398869018;16465.588360290967;16649.583760405967;14555.345009474599;14761.630959226106;14797.038192517452;14974.925125374413;15451.150186739726;11256.212065155443;11670.241434306829;11676.94161529187;11790.705232369173;12018.338991355471;2692.5826496893014;2901.012806227741;2981.9850900745573;3028.6971302869756;3086.2592977685417;95914.5204273981;98662.50668746683;99134.0086599132;99454.00545994593;99811.0018899809;11385.316880987002;11427.428628568538;11523.48144333507;11536.365499897585;11919.463624136935;24420.511589768106;24707;25045.499090018096;25056.874715626305;25119.372015699388;6920.792376228721;7615.200403957616;7674.769756907302;7682.200637621679;7904.960475197702;4100.323446631272;4116.921766602126;4172.232457207537;4192.748435093904;4214.683898707609;4105.97947010269;4128.256913755493;4186.979065104655;4228.112096459717;4228.809703563347;759.8252401947473;767.8425922685836;775.6276987046136;777.6422845491137;791.0309870408703;531.1978911843067;545.615341184464;558.6592178770946;562.8114581615123;592;9804.885070307784;10020.448875311928;10082.395056296498;10176.542055607515;10336.431496267778;543.7656519700258;556.935952365475;580.7009390164069;582.1616871704816;592.5911121326271;4332.397013105108;4387.188370151533;4391.385206071152;4682.033545910657;4806.95193048072;97269;102708;104649.83924755943;104886;106543.46728266308;52672.73663631734;60954.39045609576;75465.49069018589;83389.58305208434;86989.5650521756;59761.70119149376;76642;78643.4271314582;78647.60676196583;80173.59913200396;10361.844572331573;10507.632232871812;10711;10907.78184436291;11167.38579378142;35730.64269357273;35995.46006809847;36779.26441471209;38234.85295441141;38917;52565.94868102693;59981.10028349491;61769;68304.95085147454;70951.5809683793;13652.453901843815;13748;13919.944100619048;14075.648108797363;14150.646233843825;14491.565253042425;14530.346134424188;14728.484503042342;14879.47921822731;15221.771673424686;13501.324933753076;13801.267738600158;13826.516071937434;14068.648283792578;14493.710125797636;13998;13999.370028348952;14013.43946242139;14020.789688154482;14730.410783568537;10945.45272736376;13673.384697688827;13680.452781888613;13807.51673691416;13906.165630062229;9873.802523949336;10075.445850478294;10165.491725413847;10227.386356818317;10931.180161488079;7963.323117535075;8254.215849494289;9419.481928493724;9904.603815847286;11326 20:10:03 INFO - PID 1648 | __end_tp_report 20:10:03 INFO - PID 1648 | __start_cc_report 20:10:03 INFO - PID 1648 | _x_x_mozilla_cycle_collect,1376 20:10:03 INFO - PID 1648 | __end_cc_report 20:10:03 INFO - PID 1648 | __startTimestamp1490497803413__endTimestamp 20:10:03 INFO - PID 1648 | 20:10:03 INFO - PID 1648 | ------- Summary: start ------- 20:10:03 INFO - PID 1648 | Number of tests: 6 20:10:03 INFO - PID 1648 | 20:10:03 INFO - PID 1648 | [#0] dojo.html Cycles:165 Average:6063.74 Median:6296.06 stddev:679.82 (10.8%) stddev-sans-first:650.38 20:10:03 INFO - PID 1648 | Values: 3455.3 3470.7 3475.9 3514.1 3527.8 5113.2 6098.4 6215.9 6216.8 6238.8 6142.4 6154.4 6159.3 6169.6 6190.0 4994.4 5270.4 5487.5 5493.6 5656.2 5368.3 5443.8 5542.3 5575.2 5618.0 5462.0 5525.6 5548.6 5610.6 5624.2 5481.5 5514.1 5515.6 5517.4 5544.1 5490.9 5514.7 5521.8 5544.6 5546.6 6053.3 6089.7 6109.9 6122.5 6133.2 6395.6 6406.2 6408.6 6413.6 6473.3 5574.6 6556.4 6583.0 6633.0 6639.3 6272.3 6272.9 6279.3 6288.9 6296.1 6525.4 6611.1 6778.0 6778.5 6789.5 6321.8 6359.9 6367.5 6373.2 6380.6 6413.1 6429.9 6536.6 6618.2 6638.0 6456.7 6478.2 6494.6 6508.6 6518.5 6540.4 6550.2 6562.3 6565.3 6573.2 5157.2 5223.5 5224.4 5290.9 5313.9 4644.2 4650.1 4697.1 4734.7 4751.5 6116.0 6127.3 6203.8 6226.9 6231.0 6618.5 6621.6 6631.8 6637.1 6648.2 6070.2 6224.0 6227.9 6231.7 6248.0 5659.2 5661.2 5705.9 5721.5 5743.2 6700.2 6754.4 6758.7 6761.9 6774.7 6608.1 6608.9 6609.0 6617.8 6629.9 6492.4 6565.8 6694.9 6736.4 6747.1 6463.3 6488.6 6490.1 6493.1 6512.1 6352.6 6513.9 6558.4 6577.0 6577.2 6238.3 6289.5 6318.4 6390.3 6391.6 6345.3 6410.1 6411.9 6423.6 6441.7 6195.7 6278.8 6314.1 6328.3 6338.8 5449.9 6225.8 6306.6 6433.9 6434.8 6191.8 6319.2 6324.5 6327.1 6332.7 20:10:03 INFO - PID 1648 | 20:10:03 INFO - PID 1648 | [#1] ext.html Cycles:180 Average:52697.98 Median:36247.23 stddev:107065.34 (295.4%) stddev-sans-first:107294.66 20:10:03 INFO - PID 1648 | Values: 756.9 776.9 798.8 1128.6 1151.7 27168.0 36049.6 36473.0 36486.8 36572.0 37394.6 37623.2 37668.8 37712.1 37723.0 8429.9 8606.2 8609.4 8622.2 8632.7 6086.4 6237.3 6239.8 6240.8 6248.3 6196.6 8407.7 8554.9 8569.6 8574.8 8545.2 8605.4 8610.7 8617.4 8617.6 8473.1 8528.4 8560.9 8564.3 8565.7 36444.8 36740.0 38227.9 38271.4 38332.8 2921.7 2983.4 2992.2 2997.3 3034.6 20587.8 26249.0 26383.6 26753.9 27046.3 2761.0 2763.3 2764.6 2766.3 2770.1 288431.0 306522.0 308067.0 308644.0 309081.0 48366.0 48434.0 48511.3 48556.5 48565.0 50607.5 50649.0 50662.5 50719.7 50854.7 14282.0 14556.3 14572.7 14584.1 14594.3 11824.2 11824.7 11831.8 11849.0 11866.7 11405.4 11591.6 13382.5 13726.5 13757.6 4805.6 5641.9 5764.6 5774.2 5778.0 934.3 957.2 981.9 982.2 1003.2 27944.3 28144.3 28746.6 28790.4 28826.9 1050.6 1053.7 1093.9 1105.7 1110.2 11482.1 11492.9 12091.0 12162.0 12190.5 384059.0 447240.0 448529.0 450162.0 450297.0 52580.7 52846.7 52948.0 53040.0 53045.9 1409.1 1460.8 1481.3 1482.8 1496.7 23319.9 23338.2 23341.3 23391.3 23467.3 37619.2 37846.0 37881.0 37883.2 37951.8 446079.0 450997.5 451487.7 453336.0 453387.5 27075.0 32278.0 33666.8 33823.5 33870.2 41176.8 41284.0 41441.6 41759.8 42471.0 27904.4 27954.7 28138.7 28882.1 29383.0 28918.7 29291.3 29585.4 30020.8 30300.2 35488.6 36531.6 36570.1 36597.0 36650.8 29141.4 30017.0 31075.4 31076.8 31118.0 20634.0 23951.4 24109.2 24245.1 24347.1 20:10:03 INFO - PID 1648 | 20:10:03 INFO - PID 1648 | [#2] jquery.html Cycles:180 Average:36093.36 Median:23181.88 stddev:92611.39 (399.5%) stddev-sans-first:92832.31 20:10:03 INFO - PID 1648 | Values: 353.1 363.0 421.3 432.3 447.7 12657.7 14673.0 14754.0 20670.3 21080.6 18950.4 19877.8 22442.2 22988.9 23374.9 5904.2 6131.8 6161.6 6346.6 6361.0 5412.6 6093.8 6139.0 6151.1 6155.3 3649.7 3947.8 4028.7 6116.3 6334.9 6307.0 6309.5 6311.7 6317.5 6328.9 5362.3 5370.3 5418.1 5420.6 5424.5 26838.5 27194.5 27381.9 27728.0 28014.0 1950.9 1955.5 1970.2 1975.0 2001.5 15129.6 15857.6 16202.0 16519.0 16632.8 1655.3 1667.4 1667.9 1688.8 1711.2 128561.0 135652.3 156824.0 159025.2 161549.0 12050.0 12147.5 12247.7 12345.7 12880.3 16533.9 16615.0 16615.3 16622.8 16639.0 8608.6 8987.4 9005.4 9104.2 9147.5 8570.6 8596.0 8620.4 8768.7 8794.8 6973.9 7171.6 7753.3 7774.7 7808.7 2062.1 2076.2 2077.6 2081.7 2263.8 744.5 851.0 863.9 881.2 918.4 18214.3 20517.8 20664.4 20714.7 21150.5 883.5 926.8 953.5 954.6 966.3 9060.2 10386.2 10620.6 10640.8 10718.8 530902.0 540381.0 542031.0 542212.0 542655.0 133302.0 150281.0 153675.5 164186.0 165348.0 1183.7 1223.8 1241.8 1242.7 1252.6 20756.0 21692.1 21991.1 22020.9 22276.7 64625.0 64943.7 65278.7 65756.3 65803.0 76288.0 91307.0 93437.5 94856.0 94860.0 7215.9 7377.7 7953.2 8583.5 9135.5 14151.9 14155.9 14382.6 14569.0 14629.5 11596.2 11776.9 12145.6 12184.2 12201.8 9850.5 10755.8 10985.4 11264.0 11541.0 11894.9 11951.9 12028.3 12202.0 12333.8 8735.9 8857.7 8925.7 8997.8 9020.7 9948.8 10140.7 10163.6 10543.7 10672.3 20:10:03 INFO - PID 1648 | 20:10:03 INFO - PID 1648 | [#3] mootools.html Cycles:180 Average:6762.82 Median:2471.02 stddev:4246.09 (171.8%) stddev-sans-first:4237.86 20:10:03 INFO - PID 1648 | Values: 1259.5 1393.6 1417.8 1422.2 1428.1 10416.9 10835.7 10852.9 10855.6 10859.1 10479.1 10918.1 10923.5 10935.2 10951.8 2410.0 2467.1 2470.0 2472.0 2477.7 2043.5 2333.6 2411.3 2466.8 2467.6 2090.0 2118.1 2368.4 2456.2 2462.7 2417.9 2419.4 2423.8 2425.6 2431.9 2383.5 2416.3 2416.5 2418.6 2418.6 10892.8 11130.0 11132.9 11150.9 11158.6 6120.8 6350.1 6353.8 6361.4 6363.1 3647.7 3776.6 3817.2 3851.8 3853.7 1132.5 1172.3 1204.0 1205.1 1217.9 15446.2 15533.4 15622.2 15624.3 15626.5 4444.4 5056.6 5251.4 5392.0 5412.3 11586.9 11618.9 11621.0 11637.9 11684.0 6283.2 6286.7 6300.3 6301.3 6304.7 5654.7 5787.8 5852.9 5907.9 5924.0 3827.4 3949.8 3973.2 4011.1 4037.8 1248.7 1254.4 1257.9 1269.0 1272.1 563.0 669.4 750.4 757.5 797.1 6392.3 6492.7 6546.7 6646.1 6700.7 553.2 594.6 595.8 596.9 691.0 3783.0 4095.3 4118.3 4175.8 4364.1 13383.0 14210.9 14221.0 14229.6 14260.5 10739.9 14056.6 14244.6 14261.9 14309.0 8054.3 10189.2 10208.2 10208.6 10214.9 5718.5 6078.9 6527.9 6866.0 6927.6 11974.8 12527.7 12545.5 12567.2 12594.7 12176.3 12517.6 12547.9 12602.7 12664.5 7598.5 9144.0 9368.9 9386.1 9388.4 9840.8 10175.0 10308.8 10337.4 10398.7 8574.4 8590.4 8670.5 8801.9 8802.0 8414.3 8485.6 8552.2 8594.2 8641.6 7585.9 7817.6 7857.6 7910.5 7970.5 4865.6 5701.9 5886.7 5911.6 6087.0 5337.3 5821.2 5873.1 6050.6 6250.5 20:10:03 INFO - PID 1648 | 20:10:03 INFO - PID 1648 | [#4] prototype.html Cycles:180 Average:5109.82 Median:5746.74 stddev:1612.88 (28.1%) stddev-sans-first:1578.01 20:10:03 INFO - PID 1648 | Values: 389.4 394.3 394.4 401.9 404.8 4655.7 4967.2 6003.6 6033.5 6134.6 5063.6 5722.2 5905.4 5939.6 5944.9 3476.3 4417.4 4534.8 4683.6 4693.7 4513.2 4522.9 4551.0 4551.9 4574.9 3613.0 4435.2 4495.8 4535.1 4552.2 3512.7 3931.3 4480.5 4523.0 4552.4 3533.7 3693.9 3834.3 3879.2 3895.0 4806.0 5302.0 5450.7 5844.7 5893.4 4378.3 4474.4 5043.7 5245.3 5248.5 6292.9 6344.6 6363.5 6366.9 6370.7 4275.5 4289.3 4292.6 4296.9 4307.7 6063.0 6331.5 6419.4 6614.5 6654.1 3987.5 4064.5 4329.9 4338.8 4354.6 3726.9 4390.0 4405.0 4425.2 4450.8 4501.5 5120.9 5188.8 5190.9 5219.3 5233.6 5952.8 6291.3 6340.2 6354.1 1298.9 1495.7 1518.0 1521.1 1531.2 937.3 994.9 998.8 1002.6 1015.5 5226.3 5950.0 5950.7 5988.3 5990.5 6628.9 6685.9 6704.9 6712.8 6716.6 4604.7 4942.7 5889.9 5904.5 5984.9 3437.5 3486.2 3495.5 3501.7 3504.5 5318.0 6034.9 6306.7 6782.9 6830.8 6503.0 6737.8 6831.8 6846.2 6850.5 5640.9 5771.2 6621.0 6632.7 6638.6 5850.9 6553.6 6575.6 6670.6 6713.6 6268.8 6553.1 6561.4 6583.9 6598.4 6754.4 6758.5 6765.8 6815.6 6837.9 3818.3 3845.7 4135.9 4303.1 4323.4 6618.7 6635.5 6651.2 6652.2 6685.9 5513.0 6151.8 6389.2 6432.9 6514.5 6367.8 6410.7 6422.0 6426.9 6428.2 5496.3 6280.6 6293.2 6363.1 6374.6 5227.0 5340.6 5913.9 6059.3 6428.1 5386.8 5509.8 5939.3 6150.1 6269.7 20:10:03 INFO - PID 1648 | 20:10:03 INFO - PID 1648 | [#5] yui.html Cycles:180 Average:19383.42 Median:4122.59 stddev:27223.07 (660.3%) stddev-sans-first:27263.08 20:10:03 INFO - PID 1648 | Values: 647.0 712.2 727.8 731.5 735.3 13462.4 14207.3 15253.2 15880.5 15893.9 14213.9 14698.0 14881.3 15067.8 15137.6 784.3 948.0 951.3 953.3 953.8 916.1 944.5 949.6 960.7 961.3 973.9 976.8 979.1 980.2 980.5 975.2 976.7 977.3 978.1 978.8 723.1 723.7 725.4 725.5 725.8 13655.7 15812.2 16400.8 16465.6 16649.6 14555.3 14761.6 14797.0 14974.9 15451.2 11256.2 11670.2 11676.9 11790.7 12018.3 2692.6 2901.0 2982.0 3028.7 3086.3 95914.5 98662.5 99134.0 99454.0 99811.0 11385.3 11427.4 11523.5 11536.4 11919.5 24420.5 24707.0 25045.5 25056.9 25119.4 6920.8 7615.2 7674.8 7682.2 7905.0 4100.3 4116.9 4172.2 4192.7 4214.7 4106.0 4128.3 4187.0 4228.1 4228.8 759.8 767.8 775.6 777.6 791.0 531.2 545.6 558.7 562.8 592.0 9804.9 10020.4 10082.4 10176.5 10336.4 543.8 556.9 580.7 582.2 592.6 4332.4 4387.2 4391.4 4682.0 4807.0 97269.0 102708.0 104649.8 104886.0 106543.5 52672.7 60954.4 75465.5 83389.6 86989.6 59761.7 76642.0 78643.4 78647.6 80173.6 10361.8 10507.6 10711.0 10907.8 11167.4 35730.6 35995.5 36779.3 38234.9 38917.0 52565.9 59981.1 61769.0 68305.0 70951.6 13652.5 13748.0 13919.9 14075.6 14150.6 14491.6 14530.3 14728.5 14879.5 15221.8 13501.3 13801.3 13826.5 14068.6 14493.7 13998.0 13999.4 14013.4 14020.8 14730.4 10945.5 13673.4 13680.5 13807.5 13906.2 9873.8 10075.4 10165.5 10227.4 10931.2 7963.3 8254.2 9419.5 9904.6 11326.0 20:10:03 INFO - PID 1648 | -------- Summary: end -------- 20:10:03 INFO - PID 1648 | 20:10:04 INFO - TEST-INFO | 1648: exit 0 20:10:04 INFO - TEST-OK | dromaeo_css | took 1120608ms 20:10:04 INFO - TEST-START | kraken 20:10:04 INFO - operating with platform_type : mac_ 20:10:04 INFO - Initialising browser for kraken test... 20:10:04 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpNNLDee/profile http://localhost:49249/getInfo.html) 20:10:06 INFO - PID 1653 | __metrics Screen width/height:1600/1200 20:10:06 INFO - PID 1653 | colorDepth:24 20:10:06 INFO - PID 1653 | Browser inner width/height: 1024/689 20:10:06 INFO - PID 1653 | __metrics 20:10:06 ERROR - PID 1653 | 1490497806493 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 20:10:06 INFO - PID 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:10:06 INFO - PID 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:10:07 INFO - TEST-INFO | 1653: exit 0 20:10:07 INFO - Browser initialized. 20:10:07 INFO - Running cycle 1/1 for kraken test... 20:10:07 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpNNLDee/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:19 INFO - PID 1654 | RSS: Main: 233893888 20:10:19 INFO - PID 1654 | 20:10:22 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 20:10:23 INFO - PID 1654 | RSS: Main: 284844032 20:10:23 INFO - PID 1654 | 20:10:25 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 20:10:26 INFO - PID 1654 | RSS: Main: 287162368 20:10:26 INFO - PID 1654 | 20:10:29 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 20:10:30 INFO - PID 1654 | RSS: Main: 378306560 20:10:30 INFO - PID 1654 | 20:10:32 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 20:10:32 INFO - PID 1654 | RSS: Main: 281522176 20:10:32 INFO - PID 1654 | 20:10:34 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:10:35 INFO - PID 1654 | RSS: Main: 283803648 20:10:35 INFO - PID 1654 | 20:10:38 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 20:10:39 INFO - PID 1654 | RSS: Main: 325140480 20:10:39 INFO - PID 1654 | 20:10:42 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 20:10:42 INFO - PID 1654 | RSS: Main: 342417408 20:10:42 INFO - PID 1654 | 20:10:45 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 20:10:46 INFO - PID 1654 | RSS: Main: 351211520 20:10:46 INFO - PID 1654 | 20:10:48 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:10:48 INFO - PID 1654 | RSS: Main: 303050752 20:10:48 INFO - PID 1654 | 20:10:50 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:10:51 INFO - PID 1654 | RSS: Main: 307580928 20:10:51 INFO - PID 1654 | 20:10:53 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:10:54 INFO - PID 1654 | RSS: Main: 309854208 20:10:54 INFO - PID 1654 | 20:10:57 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:10:57 INFO - PID 1654 | RSS: Main: 324132864 20:10:57 INFO - PID 1654 | 20:11:01 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:01 INFO - PID 1654 | RSS: Main: 318451712 20:11:01 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 20:11:03 INFO - PID 1654 | RSS: Main: 380084224 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | __start_tp_report 20:11:03 INFO - PID 1654 | _x_x_mozilla_page_load 20:11:03 INFO - PID 1654 | _x_x_mozilla_page_load_details 20:11:03 INFO - PID 1654 | |i|pagename|runs| 20:11:03 INFO - PID 1654 | |0;ai-astar;112;113;112;112;112;112;111;113;113;111 20:11:03 INFO - PID 1654 | |1;audio-beat-detection;149;110;113;151;114;111;111;111;146;136 20:11:03 INFO - PID 1654 | |2;audio-dft;183;184;181;185;185;181;182;182;182;183 20:11:03 INFO - PID 1654 | |3;audio-fft;79;61;59;90;62;62;59;62;84;47 20:11:03 INFO - PID 1654 | |4;audio-oscillator;92;70;88;69;70;69;84;68;69;84 20:11:03 INFO - PID 1654 | |5;imaging-gaussian-blur;88;87;88;88;88;88;87;88;89;89 20:11:03 INFO - PID 1654 | |6;imaging-darkroom;94;95;96;94;94;94;95;95;95;95 20:11:03 INFO - PID 1654 | |7;imaging-desaturate;133;130;83;84;86;82;83;84;84;86 20:11:03 INFO - PID 1654 | |8;json-parse-financial;62;60;61;61;61;60;62;88;92;91 20:11:03 INFO - PID 1654 | |9;json-stringify-tinderbox;53;60;55;69;62;61;57;57;56;57 20:11:03 INFO - PID 1654 | |10;stanford-crypto-aes;84;84;82;81;82;83;82;82;82;81 20:11:03 INFO - PID 1654 | |11;stanford-crypto-ccm;140;138;142;158;135;154;141;137;181;126 20:11:03 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;185;182;188;202;187;195;185;166;215;208 20:11:03 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;69;69;68;68;70;70;69;68;68;70 20:11:03 INFO - PID 1654 | __end_tp_report 20:11:03 INFO - PID 1654 | __start_cc_report 20:11:03 INFO - PID 1654 | _x_x_mozilla_cycle_collect,2260 20:11:03 INFO - PID 1654 | __end_cc_report 20:11:03 INFO - PID 1654 | __startTimestamp1490497863785__endTimestamp 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | ------- Summary: start ------- 20:11:03 INFO - PID 1654 | Number of tests: 14 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 20:11:03 INFO - PID 1654 | Values: 112.0 113.0 112.0 112.0 112.0 112.0 111.0 113.0 113.0 111.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:125.00 stddev:17.92 (14.3%) stddev-sans-first:16.82 20:11:03 INFO - PID 1654 | Values: 149.0 110.0 113.0 151.0 114.0 111.0 111.0 111.0 146.0 136.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:1.48 (0.8%) stddev-sans-first:1.56 20:11:03 INFO - PID 1654 | Values: 183.0 184.0 181.0 185.0 185.0 181.0 182.0 182.0 182.0 183.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:66.50 Median:62.00 stddev:13.33 (21.5%) stddev-sans-first:13.35 20:11:03 INFO - PID 1654 | Values: 79.0 61.0 59.0 90.0 62.0 62.0 59.0 62.0 84.0 47.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:77.00 stddev:9.49 (12.3%) stddev-sans-first:8.19 20:11:03 INFO - PID 1654 | Values: 92.0 70.0 88.0 69.0 70.0 69.0 84.0 68.0 69.0 84.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:88.00 Median:88.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 20:11:03 INFO - PID 1654 | Values: 88.0 87.0 88.0 88.0 88.0 88.0 87.0 88.0 89.0 89.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 20:11:03 INFO - PID 1654 | Values: 94.0 95.0 96.0 94.0 94.0 94.0 95.0 95.0 95.0 95.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:84.00 stddev:20.08 (23.9%) stddev-sans-first:15.39 20:11:03 INFO - PID 1654 | Values: 133.0 130.0 83.0 84.0 86.0 82.0 83.0 84.0 84.0 86.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:69.80 Median:62.00 stddev:14.22 (22.9%) stddev-sans-first:14.80 20:11:03 INFO - PID 1654 | Values: 62.0 60.0 61.0 61.0 61.0 60.0 62.0 88.0 92.0 91.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:58.50 stddev:4.55 (7.8%) stddev-sans-first:4.33 20:11:03 INFO - PID 1654 | Values: 53.0 60.0 55.0 69.0 62.0 61.0 57.0 57.0 56.0 57.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:1.06 (1.3%) stddev-sans-first:0.93 20:11:03 INFO - PID 1654 | Values: 84.0 84.0 82.0 81.0 82.0 83.0 82.0 82.0 82.0 81.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:141.50 stddev:15.53 (11.0%) stddev-sans-first:16.35 20:11:03 INFO - PID 1654 | Values: 140.0 138.0 142.0 158.0 135.0 154.0 141.0 137.0 181.0 126.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.30 Median:191.50 stddev:14.16 (7.4%) stddev-sans-first:14.83 20:11:03 INFO - PID 1654 | Values: 185.0 182.0 188.0 202.0 187.0 195.0 185.0 166.0 215.0 208.0 20:11:03 INFO - PID 1654 | 20:11:03 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 20:11:03 INFO - PID 1654 | Values: 69.0 69.0 68.0 68.0 70.0 70.0 69.0 68.0 68.0 70.0 20:11:03 INFO - PID 1654 | -------- Summary: end -------- 20:11:03 INFO - PID 1654 | 20:11:04 INFO - TEST-INFO | 1654: exit 0 20:11:04 INFO - TEST-OK | kraken | took 60661ms 20:11:04 INFO - SUITE-END | took 1181s 20:11:04 INFO - Completed test suite (00:19:41) 20:11:04 INFO - javascript benchmark 20:11:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7544.933366702279, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3455.2571197192606, 3470.652934706531, 3475.9304813903723, 3514.139035936196, 3527.770694904831, 5113.207452844806, 6098.371716891083, 6215.91221536231, 6216.813495595128, 6238.750449982001, 6142.3550527194675, 6154.446099851012, 6159.260888693352, 6169.629822210671, 6190.0, 4994.400671919375, 5270.446603106676, 5487.451254874501, 5493.587980901429, 5656.151577263402, 5368.3021207243, 5443.8094666686675, 5542.251796007527, 5575.219469274305, 5618.044932361488, 5461.972690136564, 5525.557955363602, 5548.611597188198, 5610.607257491977, 5624.21261023457, 5481.506664400223, 5514.062609356379, 5515.61390702651, 5517.420670829585, 5544.140658197985, 5490.890182196334, 5514.696691681956, 5521.834344969617, 5544.556435485151, 5546.611737178399, 6053.303870054956, 6089.665068421235, 6109.877802443971, 6122.510199184055, 6133.233345831771, 6395.616263024233, 6406.199225096863, 6408.583442076297, 6413.647249401281, 6473.320301368382, 5574.637648552831, 6556.409923106896, 6582.9670851645915, 6633.005049242604, 6639.302873198341, 6272.341404152589, 6272.874542509125, 6279.277883043463, 6288.87422251557, 6296.0555916612875, 6525.3800888915475, 6611.140551728245, 6777.9661101695165, 6778.457723382117, 6789.490788190906, 6321.810345689637, 6359.872802543923, 6367.522435817332, 6373.203349581302, 6380.649064301415, 6413.102165696806, 6429.935700643027, 6536.57512261711, 6618.238902526175, 6638.037484564711, 6456.741730330828, 6478.1578394808375, 6494.6103233806125, 6508.60948343101, 6518.543701940914, 6540.37866402691, 6550.181227346582, 6562.278149403562, 6565.343465653396, 6573.244076931119, 5157.200633901752, 5223.4515375884985, 5224.399194092652, 5290.867728306823, 5313.867153321121, 4644.233701439292, 4650.116477869194, 4697.107549565571, 4734.692245004133, 4751.477337492873, 6116.0010150213275, 6127.34224287047, 6203.751849926042, 6226.906596401058, 6231.0, 6618.53670243088, 6621.635810030398, 6631.767888123893, 6637.070810086591, 6648.202215734143, 6070.2412198475195, 6224.004159334485, 6227.875442491125, 6231.688415579203, 6247.968760156261, 5659.151127330851, 5661.179129026268, 5705.942940570624, 5721.5136713379, 5743.224664670216, 6700.229473610597, 6754.358335958076, 6758.729650814011, 6761.864762704817, 6774.695138718868, 6608.140941677551, 6608.900866486911, 6608.966955165193, 6617.8014659560295, 6629.900551491828, 6492.35076492347, 6565.80302590923, 6694.899576506259, 6736.360045795642, 6747.122874026345, 6463.289038205699, 6488.578242414228, 6490.091387205701, 6493.123428337114, 6512.05575191604, 6352.587081839665, 6513.934860651333, 6558.409743122951, 6577.046328282277, 6577.2436169841085, 6238.251409830849, 6289.496840252677, 6318.368163183645, 6390.329015453311, 6391.616503009835, 6345.302016778059, 6410.134631824644, 6411.871762564816, 6423.614583125028, 6441.710123044568, 6195.659238741732, 6278.8430289241305, 6314.084457753692, 6328.303886572566, 6338.809835704937, 5449.891002180014, 6225.844353891189, 6306.590071645328, 6433.903491447539, 6434.774782882577, 6191.84520386994, 6319.210098737658, 6324.494040476843, 6327.11420401135, 6332.683365831782], "value": 6019.770849896963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.8561973225087, 776.9494982826116, 798.7643645124685, 1128.554221082673, 1151.7466157445358, 27168.0, 36049.63950360496, 36473.0, 36486.81756591217, 36572.0, 37394.626053739456, 37623.24753504935, 37668.811655941754, 37712.05719857005, 37723.0, 8429.915700843005, 8606.182412670787, 8609.39734218605, 8622.223999840013, 8632.741017769476, 6086.3913608639, 6237.251529816428, 6239.812805615838, 6240.812775616739, 6248.2814476335125, 6196.597221180631, 8407.747767566983, 8554.914450855505, 8569.614367353453, 8574.78563035926, 8545.23092921637, 8605.354598405082, 8610.698625548075, 8617.396782225183, 8617.61220745068, 8473.110323416076, 8528.445651032725, 8560.914390856075, 8564.272036876873, 8565.657373705044, 36444.817775911215, 36740.0, 38227.853164404834, 38271.42592861109, 38332.80833595842, 2921.6932222116584, 2983.3734915667737, 2992.1771512833925, 2997.341307759727, 3034.6055012848187, 20587.794122058738, 26249.0, 26383.604245936327, 26753.86623066892, 27046.32384190391, 2760.9585856212175, 2763.322985868455, 2764.585312203186, 2766.3222510484857, 2770.0997175917705, 288431.0, 306522.0, 308067.0, 308643.99999999773, 309081.0, 48366.0, 48434.0, 48511.27233091507, 48556.5144348552, 48565.0, 50607.49392506101, 50649.0, 50662.493375066515, 50719.74640126776, 50854.74572627113, 14282.000259981909, 14556.344964476624, 14572.708545829237, 14584.052036617586, 14594.34325455357, 11824.172307938534, 11824.704382390337, 11831.822522662167, 11849.0, 11866.703332416759, 11405.429728513707, 11591.594294199831, 13382.464701411835, 13726.45094196221, 13757.587272381845, 4805.609478218808, 5641.943580564224, 5764.567657425626, 5774.162746401748, 5777.971110144506, 934.2525979216599, 957.2198658093631, 981.896900825403, 982.2142286171035, 1003.19744204636, 27944.301392464946, 28144.29639258994, 28746.568801467994, 28790.42419151647, 28826.855865720536, 1050.6217761605815, 1053.6733612580124, 1093.8742044664966, 1105.7401510644993, 1110.2006555280186, 11482.125372179918, 11492.885071149349, 12091.0, 12162.027037836951, 12190.512379504898, 384059.0, 447240.0, 448529.0, 450162.0, 450297.0, 52580.737096314275, 52846.73576632169, 52948.0, 53040.0, 53045.93908121893, 1409.1122592766492, 1460.7540434248397, 1481.3482067890093, 1482.8072350594355, 1496.7006598680307, 23319.883400582887, 23338.18316358987, 23341.299761007198, 23391.298261052194, 23467.295981120595, 37619.247615048094, 37846.0, 37880.999999998894, 37883.242335152594, 37951.81024094862, 446079.0, 450997.4900250955, 451487.74256129825, 453336.0, 453387.4661253477, 27075.0, 32278.0, 33666.83166584151, 33823.4926476108, 33870.153246169044, 41176.794116029225, 41283.96790080272, 41441.58558414377, 41759.7912010438, 42471.0, 27904.44191116207, 27954.720452795213, 28138.71861281361, 28882.133535993955, 29383.0, 28918.7108128916, 29291.267718307212, 29585.408291834472, 30020.84989575038, 30300.24249393783, 35488.64511354853, 36531.63468365389, 36570.085747856516, 36597.0, 36650.8167459161, 29141.417171656023, 30017.0, 31075.37849243048, 31076.844615776776, 31118.0, 20634.0, 23951.401214969766, 24109.15617953363, 24245.085320826125, 24347.14784982588], "value": 17317.119841200827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.12777439723874, 362.9891103266902, 421.2606874934489, 432.27378004951686, 447.67990886516156, 12657.746845063093, 14673.0, 14754.0, 20670.27654032109, 21080.578388432223, 18950.431487055375, 19877.801221987775, 22442.214522491715, 22988.88505557474, 23374.883125584347, 5904.202932604107, 6131.816045518631, 6161.630302181861, 6346.555741098125, 6361.0, 5412.5940554458375, 6093.750781089866, 6139.0, 6151.138840562325, 6155.322914479426, 3649.671529562339, 3947.8223479943326, 4028.738132021424, 6116.266048074237, 6334.904976425358, 6306.990881458967, 6309.495240380758, 6311.7475300988135, 6317.463015643676, 6328.873422531569, 5362.276092727471, 5370.275012873251, 5418.106012507931, 5420.620556561043, 5424.484673956007, 26838.46323073547, 27194.45611087787, 27381.904723811025, 27728.02951896694, 28014.019509317077, 1950.9122089506006, 1955.4817973237105, 1970.162680860643, 1974.9506262343557, 2001.4596059063972, 15129.621759455991, 15857.60355991098, 16202.027878327339, 16519.0, 16632.83367166325, 1655.337864854056, 1667.391402138223, 1667.8999260044436, 1688.7889013873266, 1711.2384988680042, 128561.0, 135652.3217383907, 156824.0, 159025.20487397604, 161549.0, 12050.035997120209, 12147.453364598614, 12247.693807654701, 12345.691357715948, 12880.291583962971, 16533.91733041327, 16615.00309981405, 16615.335386584644, 16622.75065874013, 16639.001659900445, 8608.569571521399, 8987.41581797181, 9005.369624126379, 9104.226140778108, 9147.496887671108, 8570.614322355508, 8595.957020214859, 8620.396572240008, 8768.693095741619, 8794.824103517894, 6973.93026069743, 7171.569705817667, 7753.263439973193, 7774.727884524128, 7808.726694565663, 2062.113291284732, 2076.2421716073827, 2077.6364136276393, 2081.708560801489, 2263.807576355995, 744.4565467208968, 850.9872351914727, 863.9395242332977, 881.2245224202661, 918.3525614441802, 18214.271429142686, 20517.79482205189, 20664.380068597966, 20714.689279660815, 21150.47123821917, 883.5317281840635, 926.8470702334039, 953.5137080089204, 954.5752140297501, 966.3477152921749, 9060.184583387527, 10386.169106471463, 10620.628278010232, 10640.787184256425, 10718.839217411745, 530902.0, 540381.0, 542031.0, 542212.0, 542655.0, 133302.0, 150281.0, 153675.46324536836, 164186.0, 165348.0, 1183.680406290314, 1223.8347823043953, 1241.8013117901091, 1242.7079636285466, 1252.6116903759864, 20756.0, 21692.132314707866, 21991.120355185612, 22020.867927333882, 22276.66585001259, 64625.0, 64943.67528162329, 65278.673606631666, 65756.34243657503, 65803.0, 76288.0, 91307.0, 93437.5328123355, 94856.0, 94860.0, 7215.891761623475, 7377.704891804267, 7953.244441778022, 8583.527905965231, 9135.497547634945, 14151.858481415466, 14155.929220354245, 14382.568522944328, 14569.0, 14629.487967921072, 11596.246243994114, 11776.941115294369, 12145.574904878287, 12184.20802647825, 12201.816972745593, 9850.507474626384, 10755.784884302426, 10985.395803230898, 11264.0, 11540.961313481826, 11894.940525297665, 11951.880481195076, 12028.27830330183, 12202.0, 12333.814992775295, 8735.91264087351, 8857.689980850639, 8925.687600933936, 8997.820043599222, 9020.73709680632, 9948.751281218027, 10140.695779126638, 10163.593456261668, 10543.736406589896, 10672.30630009047], "value": 10157.842510287688, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.5213818748873, 1393.6097892590078, 1417.801507788909, 1422.224887436347, 1428.093160842865, 10416.947915260422, 10835.729106772325, 10852.891471085286, 10855.620053298137, 10859.13126949844, 10479.109275711573, 10918.07196388308, 10923.453827308642, 10935.234533582652, 10951.780964380707, 2409.975900240997, 2467.0748469324003, 2470.0119952019245, 2472.0235506974823, 2477.7398373170827, 2043.5299881027372, 2333.604682715042, 2411.3489357873364, 2466.7779899809016, 2467.5558399488086, 2090.0072465578883, 2118.120979793384, 2368.4197371643972, 2456.2140115163156, 2462.692163479565, 2417.9153729619466, 2419.4314336130997, 2423.8303318767694, 2425.599776036943, 2431.8784060797066, 2383.5232953409386, 2416.32342943976, 2416.4683769570665, 2418.576749068906, 2418.5888398972215, 10892.782144357148, 11130.0, 11132.944335278271, 11150.944245278723, 11158.553657853676, 6120.785772497941, 6350.079238510436, 6353.777617783356, 6361.427471527539, 6363.077353783676, 3647.74465787395, 3776.5845756966987, 3817.2365526894455, 3851.826667799956, 3853.7109716771356, 1132.4677401621307, 1172.302480024384, 1204.0, 1205.1021988618536, 1217.8660347361783, 15446.150461724601, 15533.378664853391, 15622.218889055388, 15624.296906639229, 15626.45307414235, 4444.400005999149, 5056.595472362203, 5251.396089449686, 5392.0, 5412.323459567554, 11586.88413115875, 11618.94190529042, 11621.0, 11637.88362116385, 11684.0, 6283.2460104787715, 6286.685665716695, 6300.30696623371, 6301.338359472189, 6304.653244071528, 5654.6889921054735, 5787.768489260467, 5852.882942341129, 5907.881842363128, 5924.022536281465, 3827.445020472016, 3949.763014219156, 3973.165635216637, 4011.0947300032253, 4037.7577345359373, 1248.7065539598186, 1254.3665448948223, 1257.905657075723, 1268.9569792633852, 1272.0904553244475, 562.9978638024323, 669.4309836638915, 750.4446709434978, 757.5379018798528, 797.123164519036, 6392.264889537762, 6492.67536623167, 6546.70539825709, 6646.069550262967, 6700.731970721116, 553.195101127858, 594.6402426531886, 595.8004068637055, 596.8537708261504, 690.9723611055603, 3783.0, 4095.3037983542868, 4118.258713431611, 4175.791210439465, 4364.061726728705, 13383.0, 14210.934179936547, 14221.0, 14229.64425889361, 14260.500882469063, 10739.946300268604, 14056.648583785487, 14244.572662820132, 14261.85738142626, 14309.0, 8054.315383192377, 10189.23580731448, 10208.234382421348, 10208.591656333663, 10214.948925255178, 5718.456746609066, 6078.939210607838, 6527.934720652733, 6865.965670171817, 6927.618980956096, 11974.820377694168, 12527.749445011232, 12545.498180072695, 12567.24058631774, 12594.748105038032, 12176.33030183313, 12517.56188533397, 12547.874521254671, 12602.684932876384, 12664.493420263087, 7598.506097103892, 9143.954280228556, 9368.906310936803, 9386.108319709616, 9388.389754665925, 9840.753981150528, 10175.0, 10308.793824123326, 10337.431441270803, 10398.740031499274, 8574.442661227, 8590.441621294596, 8670.523121228141, 8801.91198088011, 8802.031776504708, 8414.326853851555, 8485.57572121379, 8552.187542183483, 8594.183552562497, 8641.611127499153, 7585.886211706718, 7817.609119543887, 7857.646405911633, 7910.485818421784, 7970.4819186752675, 4865.610751139971, 5701.857453563694, 5886.676232807236, 5911.556633252438, 6086.969565152146, 5337.279467271868, 5821.214136091743, 5873.148393482836, 6050.636961782131, 6250.499960003098], "value": 5078.667096611529, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.43337444018954, 394.29421335808905, 394.4458036458776, 401.8874715079777, 404.84615845978544, 4655.650826188037, 4967.230079337708, 6003.639781613107, 6033.48715359195, 6134.631922084678, 5063.594912406998, 5722.227499287595, 5905.379935106816, 5939.584229103964, 5944.88110237795, 3476.3394954958476, 4417.359482874997, 4534.79593418297, 4683.601893839011, 4693.694909830867, 4513.1876262272945, 4522.851645468392, 4550.976030393168, 4551.863444096666, 4574.862754117382, 3612.9638703613023, 4435.201663700533, 4495.842645507408, 4535.138323718499, 4552.201880257297, 3512.666296701809, 3931.331673615492, 4480.507144214133, 4523.0, 4552.408186935694, 3533.6643018913164, 3693.8549049794383, 3834.328992426342, 3879.2047630236016, 3895.0, 4805.975970120162, 5302.0425901781955, 5450.672959622396, 5844.707764611795, 5893.410658934115, 4378.255696531597, 4474.373587697725, 5043.722595257259, 5245.344331958505, 5248.501392367719, 6292.937070629281, 6344.619322840645, 6363.522735794834, 6366.872662546723, 6370.713317900706, 4275.5296917339065, 4289.313709806447, 4292.635126014293, 4296.9140617187795, 4307.707687693679, 6062.969685151546, 6331.493480521547, 6419.422251997296, 6614.5039122065555, 6654.10169627099, 3987.491007913076, 4064.451299074587, 4329.870103896888, 4338.8047537860875, 4354.586314300136, 3726.9440958385103, 4390.0, 4405.0, 4425.22558552252, 4450.799714012877, 4501.527339629357, 5120.897582048413, 5188.81839135636, 5190.935858149071, 5219.347581552306, 5233.633645644768, 5952.779680165556, 6291.339409362043, 6340.207474065742, 6354.078658594478, 1298.8506321772927, 1495.6559991202084, 1518.0436325115106, 1521.0949485056374, 1531.1808182622244, 937.3063932689761, 994.8607194992707, 998.8351921932945, 1002.5588740953957, 1015.4821041268858, 5226.268322434862, 5950.018246989198, 5950.732217050157, 5988.251468566429, 5990.520758339322, 6628.933710662832, 6685.866282674319, 6704.899426508607, 6712.765053223114, 6716.5634233774645, 4604.723716577016, 4942.702491832099, 5889.882202355929, 5904.494353939718, 5984.880302393928, 3437.5015622734563, 3486.163320802989, 3495.475678648172, 3501.702355299777, 3504.5444092267844, 5318.0081929544485, 6034.9094763577705, 6306.653134077578, 6782.93217067823, 6830.795076147723, 6503.0, 6737.797866064026, 6831.838587440147, 6846.212685541127, 6850.45196384298, 5640.915386269127, 5771.249737534094, 6621.0, 6632.701528431232, 6638.5684930479365, 5850.882982340244, 6553.574017688835, 6575.63833989116, 6670.599764014175, 6713.63075030878, 6268.843278918063, 6553.082568440517, 6561.359660084979, 6583.938468612118, 6598.360655737743, 6754.3921047106, 6758.459323254227, 6765.797026089225, 6815.556988795713, 6837.897431538431, 3818.2745278397015, 3845.7309088001452, 4135.8966025848395, 4303.053328267776, 4323.437953066082, 6618.735250590115, 6635.469162466895, 6651.16860392451, 6652.201735791736, 6685.899711504234, 5513.015314486702, 6151.784687535915, 6389.169407976933, 6432.871342573028, 6514.511411644051, 6367.752446252352, 6410.679466026587, 6421.967890160519, 6426.871462570816, 6428.228612566522, 5496.31296087989, 6280.591761535486, 6293.244810622755, 6363.140975968185, 6374.58565193261, 5226.973865130803, 5340.626156169186, 5913.91129133072, 6059.3334733178435, 6428.100065990859, 5386.757595908115, 5509.807156749494, 5939.287285525765, 6150.10823430609, 6269.655168965568], "value": 4614.3539220107905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.9644169570674, 712.1952194020756, 727.8034930568747, 731.4696844787529, 735.2610626320547, 13462.394192261347, 14207.289635518222, 15253.237338133076, 15880.523584292461, 15893.920530397347, 14213.857861421382, 14698.0, 14881.25593720315, 15067.849321506808, 15137.621559461018, 784.2588753627824, 948.0045951750669, 951.2675240065146, 953.2945620241042, 953.7806304549957, 916.0564618443015, 944.4569372610742, 949.6343907595591, 960.7213907966682, 961.2502248246379, 973.8928717841031, 976.7899901521172, 979.1139019187647, 980.2109302011878, 980.4852452462443, 975.1662328708993, 976.6679329028093, 977.2914636888306, 978.0561757903586, 978.7895602445473, 723.1286300008529, 723.706898706025, 725.4414101142091, 725.4631572636264, 725.7568714480656, 13655.658608534766, 15812.209389530477, 16400.75398869018, 16465.588360290967, 16649.583760405967, 14555.345009474599, 14761.630959226106, 14797.038192517452, 14974.925125374413, 15451.150186739726, 11256.212065155443, 11670.241434306829, 11676.94161529187, 11790.705232369173, 12018.338991355471, 2692.5826496893014, 2901.012806227741, 2981.9850900745573, 3028.6971302869756, 3086.2592977685417, 95914.5204273981, 98662.50668746683, 99134.0086599132, 99454.00545994593, 99811.0018899809, 11385.316880987002, 11427.428628568538, 11523.48144333507, 11536.365499897585, 11919.463624136935, 24420.511589768106, 24707.0, 25045.499090018096, 25056.874715626305, 25119.372015699388, 6920.792376228721, 7615.200403957616, 7674.769756907302, 7682.200637621679, 7904.960475197702, 4100.323446631272, 4116.921766602126, 4172.232457207537, 4192.748435093904, 4214.683898707609, 4105.97947010269, 4128.256913755493, 4186.979065104655, 4228.112096459717, 4228.809703563347, 759.8252401947473, 767.8425922685836, 775.6276987046136, 777.6422845491137, 791.0309870408703, 531.1978911843067, 545.615341184464, 558.6592178770946, 562.8114581615123, 592.0, 9804.885070307784, 10020.448875311928, 10082.395056296498, 10176.542055607515, 10336.431496267778, 543.7656519700258, 556.935952365475, 580.7009390164069, 582.1616871704816, 592.5911121326271, 4332.397013105108, 4387.188370151533, 4391.385206071152, 4682.033545910657, 4806.95193048072, 97269.0, 102708.0, 104649.83924755943, 104886.0, 106543.46728266308, 52672.73663631734, 60954.39045609576, 75465.49069018589, 83389.58305208434, 86989.5650521756, 59761.70119149376, 76642.0, 78643.4271314582, 78647.60676196583, 80173.59913200396, 10361.844572331573, 10507.632232871812, 10711.0, 10907.78184436291, 11167.38579378142, 35730.64269357273, 35995.46006809847, 36779.26441471209, 38234.85295441141, 38917.0, 52565.94868102693, 59981.10028349491, 61769.0, 68304.95085147454, 70951.5809683793, 13652.453901843815, 13748.0, 13919.944100619048, 14075.648108797363, 14150.646233843825, 14491.565253042425, 14530.346134424188, 14728.484503042342, 14879.47921822731, 15221.771673424686, 13501.324933753076, 13801.267738600158, 13826.516071937434, 14068.648283792578, 14493.710125797636, 13998.0, 13999.370028348952, 14013.43946242139, 14020.789688154482, 14730.410783568537, 10945.45272736376, 13673.384697688827, 13680.452781888613, 13807.51673691416, 13906.165630062229, 9873.802523949336, 10075.445850478294, 10165.491725413847, 10227.386356818317, 10931.180161488079, 7963.323117535075, 8254.215849494289, 9419.481928493724, 9904.603815847286, 11326.0], "value": 7433.306598215857, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 112.0, 112.0, 112.0, 111.0, 113.0, 113.0, 111.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 110.0, 113.0, 151.0, 114.0, 111.0, 111.0, 111.0, 146.0, 136.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 181.0, 185.0, 185.0, 181.0, 182.0, 182.0, 182.0, 183.0], "value": 182.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 61.0, 59.0, 90.0, 62.0, 62.0, 59.0, 62.0, 84.0, 47.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 88.0, 69.0, 70.0, 69.0, 84.0, 68.0, 69.0, 84.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 88.0, 88.0, 88.0, 87.0, 88.0, 89.0, 89.0], "value": 88.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 83.0, 84.0, 86.0, 82.0, 83.0, 84.0, 84.0, 86.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 61.0, 61.0, 60.0, 62.0, 88.0, 92.0, 91.0], "value": 69.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 60.0, 55.0, 69.0, 62.0, 61.0, 57.0, 57.0, 56.0, 57.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 81.0, 82.0, 83.0, 82.0, 82.0, 82.0, 81.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 142.0, 158.0, 135.0, 154.0, 141.0, 137.0, 181.0, 126.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 182.0, 188.0, 202.0, 187.0, 195.0, 185.0, 166.0, 215.0, 208.0], "value": 191.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 68.0, 70.0, 70.0, 69.0, 68.0, 68.0, 70.0], "value": 68.9, "unit": "score"}]}]} 20:11:05 INFO - Return code: 0 20:11:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:11:05 ERROR - # TBPL SUCCESS # 20:11:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:11:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:11:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:11:05 INFO - 2017-03-25 20:11:05.121 screenresolution[1658:10485] starting screenresolution argv=screenresolution get 20:11:05 INFO - 2017-03-25 20:11:05.123 screenresolution[1658:10485] Display 0: 1600x1200x32@60 20:11:05 INFO - 2017-03-25 20:11:05.130 screenresolution[1659:10488] starting screenresolution argv=screenresolution list 20:11:05 INFO - Available Modes on Display 0 20:11:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:11:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:11:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:11:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:11:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:11:05 INFO - Intel Iris: 20:11:05 INFO - Chipset Model: Intel Iris 20:11:05 INFO - Type: GPU 20:11:05 INFO - Bus: Built-In 20:11:05 INFO - VRAM (Dynamic, Max): 1536 MB 20:11:05 INFO - Vendor: Intel (0x8086) 20:11:05 INFO - Device ID: 0x0a2e 20:11:05 INFO - Revision ID: 0x0009 20:11:05 INFO - Displays: 20:11:05 INFO - Display: 20:11:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:11:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:11:05 INFO - Display Serial Number: 1600x1200 60 20:11:05 INFO - Main Display: Yes 20:11:05 INFO - Mirror: Off 20:11:05 INFO - Online: Yes 20:11:05 INFO - Rotation: Supported 20:11:05 INFO - Return code: 0 20:11:05 INFO - Running post-action listener: _resource_record_post_action 20:11:05 INFO - [mozharness: 2017-03-26 03:11:05.368380Z] Finished run-tests step (success) 20:11:05 INFO - Running post-run listener: _resource_record_post_run 20:11:05 INFO - Total resource usage - Wall time: 1202s; CPU: 53.0%; Read bytes: 33803264; Write bytes: 514685952; Read time: 364; Write time: 1573 20:11:05 INFO - TinderboxPrint: CPU usage
53.3% 20:11:05 INFO - TinderboxPrint: I/O read bytes / time
33,803,264 / 364 20:11:05 INFO - TinderboxPrint: I/O write bytes / time
514,685,952 / 1,573 20:11:05 INFO - TinderboxPrint: CPU idle
2,244.5 (46.7%) 20:11:05 INFO - TinderboxPrint: CPU system
955.9 (19.9%) 20:11:05 INFO - TinderboxPrint: CPU user
1,609.3 (33.5%) 20:11:05 INFO - TinderboxPrint: Swap in / out
240,758,784 / 0 20:11:05 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204935680; Write bytes: 202563584; Read time: 15810; Write time: 375 20:11:05 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 32857088; Write bytes: 302156800; Read time: 295; Write time: 1164 20:11:05 INFO - Running post-run listener: _upload_blobber_files 20:11:05 INFO - Blob upload gear active. 20:11:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:11:05 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 20:11:05 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'] 20:11:05 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 20:11:06 INFO - (blobuploader) - INFO - Open directory for files ... 20:11:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:11:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:11:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:07 INFO - (blobuploader) - INFO - Done attempting. 20:11:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:11:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:11:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:08 INFO - (blobuploader) - INFO - Done attempting. 20:11:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:11:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:11:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:09 INFO - (blobuploader) - INFO - Done attempting. 20:11:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:11:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:11:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:11 INFO - (blobuploader) - INFO - Done attempting. 20:11:11 INFO - (blobuploader) - INFO - Iteration through files over. 20:11:11 INFO - Return code: 0 20:11:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:11:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:11:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d9b529f79a204b824b91467a53718c673ce543e687b154ad817431b78a3d244d4a15d7444f9598a45ceb7bb8120713d430db1bcea76d1ef4a4affabf0cb1e59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df83fff828df374afe3a4aff532f3c9265ad9ccc1ee15b8c5869a6616872292b04dd3d0f16dd6cd87e2d1179ac7997305f3dd595c88da20eb5f0da81f1bcc0d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0871b26a6c2c377639bae408315a76dc95709fef518ddea8a92d6f1e3840d023a46e4258f597b86df451fce4e69935f5fe2aa90ea850fa9e80183bdd6c6f0cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d2d17b57e2bcdb83d142900418317f385fec7e10d2df0fa3deb65736eaf05e291964c1b93cca90d29aab707c0f5dbea881af53300eed22f5783d2a25d0ffbde"} 20:11:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:11:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:11:11 INFO - Contents: 20:11:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d9b529f79a204b824b91467a53718c673ce543e687b154ad817431b78a3d244d4a15d7444f9598a45ceb7bb8120713d430db1bcea76d1ef4a4affabf0cb1e59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df83fff828df374afe3a4aff532f3c9265ad9ccc1ee15b8c5869a6616872292b04dd3d0f16dd6cd87e2d1179ac7997305f3dd595c88da20eb5f0da81f1bcc0d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0871b26a6c2c377639bae408315a76dc95709fef518ddea8a92d6f1e3840d023a46e4258f597b86df451fce4e69935f5fe2aa90ea850fa9e80183bdd6c6f0cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d2d17b57e2bcdb83d142900418317f385fec7e10d2df0fa3deb65736eaf05e291964c1b93cca90d29aab707c0f5dbea881af53300eed22f5783d2a25d0ffbde"} 20:11:11 INFO - Running post-run listener: copy_logs_to_upload_dir 20:11:11 INFO - Copying logs to upload dir... 20:11:11 INFO - mkdir: /builds/slave/test/build/upload/logs 20:11:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.855868 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-25 20:11:11.972664) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 20:11:11.975729) ========= 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.nXjTCtrAY8/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.zfluheiGEo/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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/4d9b529f79a204b824b91467a53718c673ce543e687b154ad817431b78a3d244d4a15d7444f9598a45ceb7bb8120713d430db1bcea76d1ef4a4affabf0cb1e59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df83fff828df374afe3a4aff532f3c9265ad9ccc1ee15b8c5869a6616872292b04dd3d0f16dd6cd87e2d1179ac7997305f3dd595c88da20eb5f0da81f1bcc0d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0871b26a6c2c377639bae408315a76dc95709fef518ddea8a92d6f1e3840d023a46e4258f597b86df451fce4e69935f5fe2aa90ea850fa9e80183bdd6c6f0cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d2d17b57e2bcdb83d142900418317f385fec7e10d2df0fa3deb65736eaf05e291964c1b93cca90d29aab707c0f5dbea881af53300eed22f5783d2a25d0ffbde"} build_url:https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011017 build_url: 'https://queue.taskcluster.net/v1/task/B3zMKJ-NSoeCISNtEwu01Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d9b529f79a204b824b91467a53718c673ce543e687b154ad817431b78a3d244d4a15d7444f9598a45ceb7bb8120713d430db1bcea76d1ef4a4affabf0cb1e59", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/df83fff828df374afe3a4aff532f3c9265ad9ccc1ee15b8c5869a6616872292b04dd3d0f16dd6cd87e2d1179ac7997305f3dd595c88da20eb5f0da81f1bcc0d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0871b26a6c2c377639bae408315a76dc95709fef518ddea8a92d6f1e3840d023a46e4258f597b86df451fce4e69935f5fe2aa90ea850fa9e80183bdd6c6f0cd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d2d17b57e2bcdb83d142900418317f385fec7e10d2df0fa3deb65736eaf05e291964c1b93cca90d29aab707c0f5dbea881af53300eed22f5783d2a25d0ffbde"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-25 20:11:12.011731) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 20:11:12.012456) ========= 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.nXjTCtrAY8/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.zfluheiGEo/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005170 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-25 20:11:12.064994) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 20:11:12.065783) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-25 20:11:12.066390) ========= ========= Total master_lag: 0.18 =========