builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0068 starttime: 1491011947.22 results: success (0) buildid: 20170331174923 builduid: 0ff69621b353414cad14b576d6b2c39e revision: 00a166a8640dffa2e0f48650f966d75ca3c1836e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:07.217268) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:07.217705) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:07.217975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:07.242804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:07.243120) ========= 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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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-31 18:59:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.9M=0.001s 2017-03-31 18:59:07 (16.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148617 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:07.419166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:07.419734) ========= 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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.021654 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:07.472241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 18:59:07.472603) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 00a166a8640dffa2e0f48650f966d75ca3c1836e --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 00a166a8640dffa2e0f48650f966d75ca3c1836e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OgtL1Aak7J/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.YIaIioRgyZ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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-31 18:59:07,535 truncating revision to first 12 chars 2017-03-31 18:59:07,536 Setting DEBUG logging. 2017-03-31 18:59:07,536 attempt 1/10 2017-03-31 18:59:07,536 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/00a166a8640d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 18:59:09,047 unpacking tar archive at: mozilla-central-00a166a8640d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.778807 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-31 18:59:09.281644) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:09.281984) ========= script_repo_revision: 00a166a8640dffa2e0f48650f966d75ca3c1836e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:09.282398) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:09.282699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 18:59:09.303167) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2017-03-31 18:59:09.303683) ========= /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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 18:59:09 INFO - MultiFileLogger online at 20170331 18:59:09 in /builds/slave/test 18:59:09 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 18:59:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:59:09 INFO - {'append_to_log': False, 18:59:09 INFO - 'base_work_dir': '/builds/slave/test', 18:59:09 INFO - 'blob_upload_branch': 'Firefox', 18:59:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:59:09 INFO - 'branch': 'Firefox', 18:59:09 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:09 INFO - 'config_files': ('talos/mac_config.py',), 18:59:09 INFO - 'default_actions': ('clobber', 18:59:09 INFO - 'read-buildbot-config', 18:59:09 INFO - 'download-and-extract', 18:59:09 INFO - 'populate-webroot', 18:59:09 INFO - 'create-virtualenv', 18:59:09 INFO - 'install', 18:59:09 INFO - 'run-tests'), 18:59:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:09 INFO - 'download_minidump_stackwalk': True, 18:59:09 INFO - 'download_symbols': 'ondemand', 18:59:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:09 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:09 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:09 INFO - 'gecko_profile': False, 18:59:09 INFO - 'gecko_profile_interval': 0, 18:59:09 INFO - 'installer_path': 'installer.exe', 18:59:09 INFO - 'log_level': 'info', 18:59:09 INFO - 'log_name': 'talos', 18:59:09 INFO - 'log_to_console': True, 18:59:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:59:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:59:09 INFO - 'opt_config_files': (), 18:59:09 INFO - 'pip_index': False, 18:59:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:59:09 INFO - 'cmd': ('bash', 18:59:09 INFO - '-c', 18:59:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:59:09 INFO - 'enabled': True, 18:59:09 INFO - 'halt_on_failure': False, 18:59:09 INFO - 'name': 'check_screen_resolution'},), 18:59:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:59:09 INFO - 'cmd': ('bash', 18:59:09 INFO - '-c', 18:59:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:59:09 INFO - 'enabled': True, 18:59:09 INFO - 'halt_on_failure': False, 18:59:09 INFO - 'name': 'check_screen_resolution'},), 18:59:09 INFO - 'run_cmd_checks_enabled': True, 18:59:09 INFO - 'suite': 'dromaeojs', 18:59:09 INFO - 'system_bits': '32', 18:59:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:09 INFO - 'title': 't-yosemite-r7-0068', 18:59:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:09 INFO - 'use_talos_json': True, 18:59:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:59:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:09 INFO - 'work_dir': 'build'} 18:59:09 INFO - [mozharness: 2017-04-01 01:59:09.491473Z] Running clobber step. 18:59:09 INFO - Running pre-action listener: _resource_record_pre_action 18:59:09 INFO - Running main action method: clobber 18:59:09 INFO - rmtree: /builds/slave/test/build 18:59:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:59:09 INFO - Running post-action listener: _resource_record_post_action 18:59:09 INFO - [mozharness: 2017-04-01 01:59:09.817450Z] Finished clobber step (success) 18:59:09 INFO - [mozharness: 2017-04-01 01:59:09.817707Z] Running read-buildbot-config step. 18:59:09 INFO - Running pre-action listener: _resource_record_pre_action 18:59:09 INFO - Running main action method: read_buildbot_config 18:59:09 INFO - Using buildbot properties: 18:59:09 INFO - { 18:59:09 INFO - "project": "", 18:59:09 INFO - "product": "firefox", 18:59:09 INFO - "script_repo_revision": "production", 18:59:09 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:59:09 INFO - "repository": "", 18:59:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:59:09 INFO - "buildid": "20170331174923", 18:59:09 INFO - "pgo_build": "False", 18:59:09 INFO - "basedir": "/builds/slave/test", 18:59:09 INFO - "buildnumber": 19, 18:59:09 INFO - "slavename": "t-yosemite-r7-0068", 18:59:09 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:59:09 INFO - "platform": "yosemite_r7", 18:59:09 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:59:09 INFO - "branch": "mozilla-central", 18:59:09 INFO - "repo_path": "mozilla-central", 18:59:09 INFO - "revision": "00a166a8640dffa2e0f48650f966d75ca3c1836e", 18:59:09 INFO - "stage_platform": "macosx64", 18:59:09 INFO - "builduid": "0ff69621b353414cad14b576d6b2c39e", 18:59:09 INFO - "slavebuilddir": "test" 18:59:09 INFO - } 18:59:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 18:59:09 INFO - Running post-action listener: _resource_record_post_action 18:59:09 INFO - [mozharness: 2017-04-01 01:59:09.822557Z] Finished read-buildbot-config step (success) 18:59:09 INFO - [mozharness: 2017-04-01 01:59:09.822667Z] Running download-and-extract step. 18:59:09 INFO - Running pre-action listener: _resource_record_pre_action 18:59:09 INFO - Running main action method: download_and_extract 18:59:09 INFO - mkdir: /builds/slave/test/build/tests 18:59:09 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')]} 18:59:09 INFO - trying https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 18:59:09 INFO - Downloading https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/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 18:59:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/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 18:59:10 INFO - Downloaded 1325 bytes. 18:59:10 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:59:10 INFO - Using the following test package requirements: 18:59:10 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:10 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 18:59:10 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:59:10 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:10 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 18:59:10 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:10 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 18:59:10 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:10 INFO - u'jsshell-mac.zip'], 18:59:10 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:10 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 18:59:10 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:59:10 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:10 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 18:59:10 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:10 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 18:59:10 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:10 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 18:59:10 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:59:10 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 18:59:10 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:59:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:59:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:59:10 INFO - Fetch https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:59:12 INFO - Expected file size: 52507896 18:59:12 INFO - Obtained file size: 52507896 18:59:29 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 18:59:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:59:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:59:29 INFO - Fetch https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:59:30 INFO - Expected file size: 52507896 18:59:30 INFO - Obtained file size: 52507896 18:59:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 18:59:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:59:46 INFO - Fetch https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 18:59:54 INFO - Expected file size: 14404152 18:59:54 INFO - Obtained file size: 14404152 18:59:54 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')]} 18:59:54 INFO - trying https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:59:54 INFO - Downloading https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 18:59:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/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 18:59:56 INFO - Downloaded 75623805 bytes. 18:59:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:59:56 INFO - mkdir: /builds/slave/test/properties 18:59:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:59:56 INFO - Writing to file /builds/slave/test/properties/build_url 18:59:56 INFO - Contents: 18:59:56 INFO - build_url:https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:59:57 INFO - Running post-action listener: _resource_record_post_action 18:59:57 INFO - Running post-action listener: set_extra_try_arguments 18:59:57 INFO - [mozharness: 2017-04-01 01:59:57.543191Z] Finished download-and-extract step (success) 18:59:57 INFO - [mozharness: 2017-04-01 01:59:57.543327Z] Running populate-webroot step. 18:59:57 INFO - Running pre-action listener: _resource_record_pre_action 18:59:57 INFO - Running main action method: populate_webroot 18:59:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:59:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:59:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:59:57 INFO - '--tppagecycles', 18:59:57 INFO - '7'], 18:59:57 INFO - 'tests': ['tsvgm']}}, 18:59:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:59:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:59:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:59:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:59:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:59:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:59:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:59:57 INFO - 'talos_options': ['--disable-e10s'], 18:59:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:59:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:59:57 INFO - 'talos_options': ['--disable-e10s'], 18:59:57 INFO - 'tests': ['damp', 'tps']}, 18:59:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:59:57 INFO - 'tests': ['damp', 'tps']}, 18:59:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:59:57 INFO - 'tests': ['dromaeo_dom']}, 18:59:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:59:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:59:57 INFO - 'tests': ['basic_compositor_video']}, 18:59:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:59:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:59:57 INFO - 'tests': ['a11yr', 18:59:57 INFO - 'ts_paint', 18:59:57 INFO - 'tpaint', 18:59:57 INFO - 'sessionrestore', 18:59:57 INFO - 'sessionrestore_no_auto_restore', 18:59:57 INFO - 'tabpaint']}, 18:59:57 INFO - 'other-e10s': {'tests': ['a11yr', 18:59:57 INFO - 'ts_paint', 18:59:57 INFO - 'tpaint', 18:59:57 INFO - 'sessionrestore', 18:59:57 INFO - 'sessionrestore_no_auto_restore', 18:59:57 INFO - 'tabpaint']}, 18:59:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:59:57 INFO - 'ts_paint', 18:59:57 INFO - 'tpaint', 18:59:57 INFO - 'sessionrestore', 18:59:57 INFO - 'sessionrestore_no_auto_restore', 18:59:57 INFO - 'tabpaint']}, 18:59:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:59:57 INFO - 'ts_paint', 18:59:57 INFO - 'tpaint', 18:59:57 INFO - 'sessionrestore', 18:59:57 INFO - 'sessionrestore_no_auto_restore', 18:59:57 INFO - 'tabpaint']}, 18:59:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:59:57 INFO - 'tests': ['a11yr', 18:59:57 INFO - 'ts_paint', 18:59:57 INFO - 'tpaint', 18:59:57 INFO - 'sessionrestore', 18:59:57 INFO - 'sessionrestore_no_auto_restore', 18:59:57 INFO - 'tabpaint']}, 18:59:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:59:57 INFO - 'tests': ['a11yr', 18:59:57 INFO - 'ts_paint', 18:59:57 INFO - 'tpaint', 18:59:57 INFO - 'sessionrestore', 18:59:57 INFO - 'sessionrestore_no_auto_restore', 18:59:57 INFO - 'tabpaint']}, 18:59:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:59:57 INFO - 'tests': ['tsvgx', 18:59:57 INFO - 'tsvgr_opacity', 18:59:57 INFO - 'tart', 18:59:57 INFO - 'tscrollx', 18:59:57 INFO - 'cart', 18:59:57 INFO - 'tsvg_static']}, 18:59:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:59:57 INFO - 'tsvgr_opacity', 18:59:57 INFO - 'tart', 18:59:57 INFO - 'tscrollx', 18:59:57 INFO - 'cart', 18:59:57 INFO - 'tsvg_static']}, 18:59:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:59:57 INFO - 'talos_options': ['--disable-e10s'], 18:59:57 INFO - 'tests': ['tp5o']}, 18:59:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:59:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:59:57 INFO - 'talos_options': ['--disable-e10s', 18:59:57 INFO - '--xperf_path', 18:59:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:57 INFO - 'tests': ['tp5n']}, 18:59:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:59:57 INFO - 'talos_options': ['--xperf_path', 18:59:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:57 INFO - 'tests': ['tp5n']}}, 18:59:57 INFO - 'talos.zip': {'path': '', 18:59:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:59:57 INFO - Running post-action listener: _resource_record_post_action 18:59:57 INFO - [mozharness: 2017-04-01 01:59:57.562020Z] Finished populate-webroot step (success) 18:59:57 INFO - [mozharness: 2017-04-01 01:59:57.562157Z] Running create-virtualenv step. 18:59:57 INFO - Running pre-action listener: _resource_record_pre_action 18:59:57 INFO - Running main action method: create_virtualenv 18:59:57 INFO - Creating virtualenv /builds/slave/test/build/venv 18:59:57 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 18:59:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:59:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:59:57 INFO - Using real prefix '/tools/python27' 18:59:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:59:58 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:01 INFO - Installing pip.................done. 19:00:01 INFO - Return code: 0 19:00:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:00:01 INFO - Reading from file tmpfile_stdout 19:00:01 INFO - Output received: 19:00:01 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:00:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:00: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:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105985b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105988768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c0d826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105763d30>, '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 0x10568adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105758be8>, '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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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:00: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', 'pip>=1.5'] in /builds/slave/test/build 19:00: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 pip>=1.5 19:00:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgtL1Aak7J/Render', 19:00:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:01 INFO - 'HOME': '/Users/cltbld', 19:00:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:01 INFO - 'LOGNAME': 'cltbld', 19:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:01 INFO - 'MOZ_NO_REMOTE': '1', 19:00:01 INFO - 'NO_EM_RESTART': '1', 19:00:01 INFO - 'PAGER': '/bin/cat', 19:00:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:01 INFO - 'PWD': '/builds/slave/test', 19:00:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:01 INFO - 'SHELL': '/bin/bash', 19:00:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YIaIioRgyZ/Listeners', 19:00:01 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 19:00:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:01 INFO - 'USER': 'cltbld', 19:00:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:01 INFO - 'XPC_FLAGS': '0x0', 19:00:01 INFO - 'XPC_SERVICE_NAME': '0', 19:00:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:01 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:00:01 INFO - Cleaning up... 19:00:01 INFO - Return code: 0 19:00:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:00: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:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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', '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 0x105985b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105988768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c0d826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105763d30>, '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 0x10568adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105758be8>, '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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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:00: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:00: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 psutil>=3.1.1 19:00:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgtL1Aak7J/Render', 19:00:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:01 INFO - 'HOME': '/Users/cltbld', 19:00:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:01 INFO - 'LOGNAME': 'cltbld', 19:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:01 INFO - 'MOZ_NO_REMOTE': '1', 19:00:01 INFO - 'NO_EM_RESTART': '1', 19:00:01 INFO - 'PAGER': '/bin/cat', 19:00:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:01 INFO - 'PWD': '/builds/slave/test', 19:00:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:01 INFO - 'SHELL': '/bin/bash', 19:00:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YIaIioRgyZ/Listeners', 19:00:01 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 19:00:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:01 INFO - 'USER': 'cltbld', 19:00:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:01 INFO - 'XPC_FLAGS': '0x0', 19:00:01 INFO - 'XPC_SERVICE_NAME': '0', 19:00:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:02 INFO - Downloading/unpacking psutil>=3.1.1 19:00:02 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:00:02 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:00:02 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:00:02 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:00:02 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:00:02 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:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:05 INFO - Installing collected packages: psutil 19:00:05 INFO - Running setup.py install for psutil 19:00:05 INFO - building 'psutil._psutil_osx' extension 19:00:05 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:00:05 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:00:05 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:00:05 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:00:06 INFO - building 'psutil._psutil_posix' extension 19:00:06 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:00:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:00:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:00:06 INFO - ^ 19:00:06 INFO - 1 warning generated. 19:00:06 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:00:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:06 INFO - Successfully installed psutil 19:00:06 INFO - Cleaning up... 19:00:06 INFO - Return code: 0 19:00:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105985b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105988768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c0d826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105763d30>, '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 0x10568adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105758be8>, '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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgtL1Aak7J/Render', 19:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:07 INFO - 'HOME': '/Users/cltbld', 19:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:07 INFO - 'LOGNAME': 'cltbld', 19:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:07 INFO - 'MOZ_NO_REMOTE': '1', 19:00:07 INFO - 'NO_EM_RESTART': '1', 19:00:07 INFO - 'PAGER': '/bin/cat', 19:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:07 INFO - 'PWD': '/builds/slave/test', 19:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:07 INFO - 'SHELL': '/bin/bash', 19:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YIaIioRgyZ/Listeners', 19:00:07 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 19:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:07 INFO - 'USER': 'cltbld', 19:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:07 INFO - 'XPC_FLAGS': '0x0', 19:00:07 INFO - 'XPC_SERVICE_NAME': '0', 19:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:00:10 INFO - Installing collected packages: mozsystemmonitor 19:00:10 INFO - Running setup.py install for mozsystemmonitor 19:00:10 INFO - Successfully installed mozsystemmonitor 19:00:10 INFO - Cleaning up... 19:00:10 INFO - Return code: 0 19:00:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:00:10 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:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:10 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:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:10 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 0x105985b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105988768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c0d826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105763d30>, '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 0x10568adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105758be8>, '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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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:00:10 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:00:10 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:00:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgtL1Aak7J/Render', 19:00:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:10 INFO - 'HOME': '/Users/cltbld', 19:00:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:10 INFO - 'LOGNAME': 'cltbld', 19:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:10 INFO - 'MOZ_NO_REMOTE': '1', 19:00:10 INFO - 'NO_EM_RESTART': '1', 19:00:10 INFO - 'PAGER': '/bin/cat', 19:00:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:10 INFO - 'PWD': '/builds/slave/test', 19:00:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:10 INFO - 'SHELL': '/bin/bash', 19:00:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YIaIioRgyZ/Listeners', 19:00:10 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 19:00:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:10 INFO - 'USER': 'cltbld', 19:00:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:10 INFO - 'XPC_FLAGS': '0x0', 19:00:10 INFO - 'XPC_SERVICE_NAME': '0', 19:00:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:10 INFO - Downloading/unpacking jsonschema==2.5.1 19:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:00:13 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:00:13 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:00:13 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:00:13 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:00:13 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:00:13 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:00:14 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:14 INFO - warning: no files found matching '*.txt' 19:00:14 INFO - no previously-included directories found matching 'build' 19:00:14 INFO - no previously-included directories found matching 'dist' 19:00:14 INFO - no previously-included directories found matching '.git*' 19:00:14 INFO - Installing collected packages: jsonschema, functools32 19:00:14 INFO - Running setup.py install for functools32 19:00:14 INFO - warning: no files found matching '*.txt' 19:00:14 INFO - no previously-included directories found matching 'build' 19:00:14 INFO - no previously-included directories found matching 'dist' 19:00:14 INFO - no previously-included directories found matching '.git*' 19:00:14 INFO - Successfully installed jsonschema functools32 19:00:14 INFO - Cleaning up... 19:00:14 INFO - Return code: 0 19:00:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:00:14 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:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:14 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:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:14 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 0x105985b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105988768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c0d826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105763d30>, '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 0x10568adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105758be8>, '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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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:00:14 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:00:14 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:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgtL1Aak7J/Render', 19:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:14 INFO - 'HOME': '/Users/cltbld', 19:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:14 INFO - 'LOGNAME': 'cltbld', 19:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:14 INFO - 'MOZ_NO_REMOTE': '1', 19:00:14 INFO - 'NO_EM_RESTART': '1', 19:00:14 INFO - 'PAGER': '/bin/cat', 19:00:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:14 INFO - 'PWD': '/builds/slave/test', 19:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:14 INFO - 'SHELL': '/bin/bash', 19:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YIaIioRgyZ/Listeners', 19:00:14 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 19:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:14 INFO - 'USER': 'cltbld', 19:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:14 INFO - 'XPC_FLAGS': '0x0', 19:00:14 INFO - 'XPC_SERVICE_NAME': '0', 19:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:00:14 INFO - Cleaning up... 19:00:14 INFO - Return code: 0 19:00:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:00:14 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:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:14 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:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:14 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 0x105985b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105988768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c0d826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105763d30>, '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 0x10568adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105758be8>, '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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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:00:14 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:00:14 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:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgtL1Aak7J/Render', 19:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:14 INFO - 'HOME': '/Users/cltbld', 19:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:14 INFO - 'LOGNAME': 'cltbld', 19:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:14 INFO - 'MOZ_NO_REMOTE': '1', 19:00:14 INFO - 'NO_EM_RESTART': '1', 19:00:14 INFO - 'PAGER': '/bin/cat', 19:00:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:14 INFO - 'PWD': '/builds/slave/test', 19:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:14 INFO - 'SHELL': '/bin/bash', 19:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YIaIioRgyZ/Listeners', 19:00:14 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 19:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:14 INFO - 'USER': 'cltbld', 19:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:14 INFO - 'XPC_FLAGS': '0x0', 19:00:14 INFO - 'XPC_SERVICE_NAME': '0', 19:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:14 INFO - Downloading/unpacking blobuploader==1.2.4 19:00:14 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:00:14 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:00:14 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:00:14 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:00:14 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:00:14 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:00:17 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00:17 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:00:17 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:00:17 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:00:17 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:00:17 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:00:17 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:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:00:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00:18 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:00:18 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:00:18 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:00:18 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:00:18 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:00:18 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:00:18 INFO - Downloading docopt-0.6.1.tar.gz 19:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:18 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:18 INFO - Running setup.py install for blobuploader 19:00:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:00:18 INFO - Running setup.py install for requests 19:00:19 INFO - Running setup.py install for docopt 19:00:19 INFO - Successfully installed blobuploader requests docopt 19:00:19 INFO - Cleaning up... 19:00:19 INFO - Return code: 0 19:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:19 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:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:19 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:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:19 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 0x105985b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105988768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c0d826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105763d30>, '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 0x10568adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105758be8>, '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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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:00:19 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:00:19 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:00:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgtL1Aak7J/Render', 19:00:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:19 INFO - 'HOME': '/Users/cltbld', 19:00:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:19 INFO - 'LOGNAME': 'cltbld', 19:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:19 INFO - 'MOZ_NO_REMOTE': '1', 19:00:19 INFO - 'NO_EM_RESTART': '1', 19:00:19 INFO - 'PAGER': '/bin/cat', 19:00:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:19 INFO - 'PWD': '/builds/slave/test', 19:00:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:19 INFO - 'SHELL': '/bin/bash', 19:00:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YIaIioRgyZ/Listeners', 19:00:19 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 19:00:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:19 INFO - 'USER': 'cltbld', 19:00:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:19 INFO - 'XPC_FLAGS': '0x0', 19:00:19 INFO - 'XPC_SERVICE_NAME': '0', 19:00:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:19 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-_aDOGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:20 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-O3zTfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:20 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-35tS6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:20 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-TRFzkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:20 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-w4VC7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:20 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-V9B1_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:20 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-UI4TEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:20 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-EFgMi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:20 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Fvrbud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:20 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-2AIrpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:20 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-yVPZd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:21 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Ip5ItQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:21 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-4vyvtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:21 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-RXay9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:21 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Uehpt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:21 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Tw53ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:21 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-kPHPPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:21 INFO - Running setup.py install for manifestparser 19:00:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:00:21 INFO - Running setup.py install for mozcrash 19:00:21 INFO - Running setup.py install for mozdebug 19:00:22 INFO - Running setup.py install for mozdevice 19:00:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:00:22 INFO - Running setup.py install for mozfile 19:00:22 INFO - Running setup.py install for mozhttpd 19:00:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:00:22 INFO - Running setup.py install for mozinfo 19:00:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:00:22 INFO - Running setup.py install for mozInstall 19:00:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:00:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:00:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:00:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:00:22 INFO - Running setup.py install for mozleak 19:00:22 INFO - Running setup.py install for mozlog 19:00:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:00:23 INFO - Running setup.py install for moznetwork 19:00:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:00:23 INFO - Running setup.py install for mozprocess 19:00:23 INFO - Running setup.py install for mozprofile 19:00:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:00:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:00:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:00:23 INFO - Running setup.py install for mozrunner 19:00:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:00:23 INFO - Running setup.py install for mozscreenshot 19:00:23 INFO - Running setup.py install for moztest 19:00:24 INFO - Running setup.py install for mozversion 19:00:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:00:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:24 INFO - Cleaning up... 19:00:24 INFO - Return code: 0 19:00:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:24 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 0x105985b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105988768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c0d826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105763d30>, '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 0x10568adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105758be8>, '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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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:00:24 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:00:24 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:00:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgtL1Aak7J/Render', 19:00:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:24 INFO - 'HOME': '/Users/cltbld', 19:00:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:24 INFO - 'LOGNAME': 'cltbld', 19:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:24 INFO - 'MOZ_NO_REMOTE': '1', 19:00:24 INFO - 'NO_EM_RESTART': '1', 19:00:24 INFO - 'PAGER': '/bin/cat', 19:00:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:24 INFO - 'PWD': '/builds/slave/test', 19:00:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:24 INFO - 'SHELL': '/bin/bash', 19:00:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YIaIioRgyZ/Listeners', 19:00:24 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 19:00:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:24 INFO - 'USER': 'cltbld', 19:00:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:24 INFO - 'XPC_FLAGS': '0x0', 19:00:24 INFO - 'XPC_SERVICE_NAME': '0', 19:00:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:24 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-iZp7GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:24 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:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:24 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-eeezbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:24 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:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:24 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-isRvMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:24 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:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:24 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-9j4W0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:24 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:00:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:24 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-UVzA7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:25 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:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:25 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-hQW5Lo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:25 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:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:25 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-kCnUUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:25 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:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:25 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-OOcyEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:25 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:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:25 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-fbl6jN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:25 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:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:25 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-i03gsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:25 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:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:25 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-fwL02P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:25 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:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:25 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Dek60y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:25 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:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:25 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-QzvmgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:25 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:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:25 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-_dqrpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:25 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:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:26 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-eIFn5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:26 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:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:26 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-ZGXwaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:26 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:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:26 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Edp478-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:26 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:00:28 INFO - Downloading blessings-1.6.tar.gz 19:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:29 INFO - Installing collected packages: blessings 19:00:29 INFO - Running setup.py install for blessings 19:00:29 INFO - Successfully installed blessings 19:00:29 INFO - Cleaning up... 19:00:29 INFO - Return code: 0 19:00:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:00:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:29 INFO - Reading from file tmpfile_stdout 19:00:29 INFO - Current package versions: 19:00:29 INFO - blessings == 1.6 19:00:29 INFO - blobuploader == 1.2.4 19:00:29 INFO - docopt == 0.6.1 19:00:29 INFO - functools32 == 3.2.3-2 19:00:29 INFO - jsonschema == 2.5.1 19:00:29 INFO - manifestparser == 1.1 19:00:29 INFO - mozInstall == 1.12 19:00:29 INFO - mozcrash == 1.0 19:00:29 INFO - mozdebug == 0.1 19:00:29 INFO - mozdevice == 0.49 19:00:29 INFO - mozfile == 1.2 19:00:29 INFO - mozhttpd == 0.7 19:00:29 INFO - mozinfo == 0.9 19:00:29 INFO - mozleak == 0.1 19:00:29 INFO - mozlog == 3.4 19:00:29 INFO - moznetwork == 0.27 19:00:29 INFO - mozprocess == 0.25 19:00:29 INFO - mozprofile == 0.28 19:00:29 INFO - mozrunner == 6.13 19:00:29 INFO - mozscreenshot == 0.1 19:00:29 INFO - mozsystemmonitor == 0.3 19:00:29 INFO - moztest == 0.8 19:00:29 INFO - mozversion == 1.4 19:00:29 INFO - psutil == 3.1.1 19:00:29 INFO - requests == 1.2.3 19:00:29 INFO - wsgiref == 0.1.2 19:00:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:29 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:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:29 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:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:29 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 0x105985b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105988768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c0d826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105763d30>, '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 0x10568adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105758be8>, '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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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:00:29 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:00:29 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:00:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgtL1Aak7J/Render', 19:00:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:29 INFO - 'HOME': '/Users/cltbld', 19:00:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:29 INFO - 'LOGNAME': 'cltbld', 19:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:29 INFO - 'MOZ_NO_REMOTE': '1', 19:00:29 INFO - 'NO_EM_RESTART': '1', 19:00:29 INFO - 'PAGER': '/bin/cat', 19:00:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:29 INFO - 'PWD': '/builds/slave/test', 19:00:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:29 INFO - 'SHELL': '/bin/bash', 19:00:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YIaIioRgyZ/Listeners', 19:00:29 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 19:00:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:29 INFO - 'USER': 'cltbld', 19:00:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:29 INFO - 'XPC_FLAGS': '0x0', 19:00:29 INFO - 'XPC_SERVICE_NAME': '0', 19:00:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:29 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:00:29 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:00:29 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:00:29 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:00:29 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:00:29 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:00:29 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:00:29 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:00:29 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:00:29 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:00:29 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:00:29 INFO - Cleaning up... 19:00:29 INFO - Return code: 0 19:00:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:00:29 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:00:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:29 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:00:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:29 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 0x105985b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105988768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1c0d826c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105763d30>, '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 0x10568adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105758be8>, '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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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:00:29 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:00:29 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:00:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgtL1Aak7J/Render', 19:00:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:29 INFO - 'HOME': '/Users/cltbld', 19:00:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:29 INFO - 'LOGNAME': 'cltbld', 19:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:29 INFO - 'MOZ_NO_REMOTE': '1', 19:00:29 INFO - 'NO_EM_RESTART': '1', 19:00:29 INFO - 'PAGER': '/bin/cat', 19:00:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:29 INFO - 'PWD': '/builds/slave/test', 19:00:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:29 INFO - 'SHELL': '/bin/bash', 19:00:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YIaIioRgyZ/Listeners', 19:00:29 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 19:00:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:29 INFO - 'USER': 'cltbld', 19:00:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:29 INFO - 'XPC_FLAGS': '0x0', 19:00:29 INFO - 'XPC_SERVICE_NAME': '0', 19:00:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:00:30 INFO - Cleaning up... 19:00:30 INFO - Return code: 0 19:00:30 INFO - Running post-action listener: _resource_record_post_action 19:00:30 INFO - Running post-action listener: _start_resource_monitoring 19:00:30 INFO - Starting resource monitoring. 19:00:30 INFO - [mozharness: 2017-04-01 02:00:30.159607Z] Finished create-virtualenv step (success) 19:00:30 INFO - [mozharness: 2017-04-01 02:00:30.160578Z] Running install step. 19:00:30 INFO - Running pre-action listener: _resource_record_pre_action 19:00:30 INFO - Running main action method: install 19:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:30 INFO - Reading from file tmpfile_stdout 19:00:30 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:00:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:00:30 INFO - Reading from file tmpfile_stdout 19:00:30 INFO - Output received: 19:00:30 INFO - Usage: mozinstall [options] installer 19:00:30 INFO - Options: 19:00:30 INFO - -h, --help show this help message and exit 19:00:30 INFO - -d DEST, --destination=DEST 19:00:30 INFO - Directory to install application into. [default: 19:00:30 INFO - "/builds/slave/test"] 19:00:30 INFO - --app=APP Application being installed. [default: firefox] 19:00:30 INFO - mkdir: /builds/slave/test/build/application 19:00:30 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:00:30 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:00:50 INFO - Reading from file tmpfile_stdout 19:00:50 INFO - Output received: 19:00:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:00:50 INFO - Running post-action listener: _resource_record_post_action 19:00:50 INFO - [mozharness: 2017-04-01 02:00:50.576345Z] Finished install step (success) 19:00:50 INFO - [mozharness: 2017-04-01 02:00:50.576469Z] Running run-tests step. 19:00:50 INFO - Running pre-action listener: _resource_record_pre_action 19:00:50 INFO - Running main action method: run_tests 19:00:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:00:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:00:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:00:50 INFO - 2017-03-31 19:00:50.591 screenresolution[1986:19809] starting screenresolution argv=screenresolution get 19:00:50 INFO - 2017-03-31 19:00:50.594 screenresolution[1986:19809] Display 0: 1600x1200x32@60 19:00:50 INFO - 2017-03-31 19:00:50.600 screenresolution[1987:19812] starting screenresolution argv=screenresolution list 19:00:50 INFO - Available Modes on Display 0 19:00:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:00:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:00:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:00:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:00:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:00:50 INFO - Intel Iris: 19:00:50 INFO - Chipset Model: Intel Iris 19:00:50 INFO - Type: GPU 19:00:50 INFO - Bus: Built-In 19:00:50 INFO - VRAM (Dynamic, Max): 1536 MB 19:00:50 INFO - Vendor: Intel (0x8086) 19:00:50 INFO - Device ID: 0x0a2e 19:00:50 INFO - Revision ID: 0x0009 19:00:50 INFO - Displays: 19:00:50 INFO - Display: 19:00:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:00:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:00:50 INFO - Display Serial Number: 1600x1200 60 19:00:50 INFO - Main Display: Yes 19:00:50 INFO - Mirror: Off 19:00:50 INFO - Online: Yes 19:00:50 INFO - Rotation: Supported 19:00:50 INFO - Return code: 0 19:00:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:00:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:00:50 INFO - Python 2.7.3 19:00:50 INFO - Return code: 0 19:00:50 INFO - grabbing minidump binary from tooltool 19:00:50 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:00:50 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 0x105763d30>, '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 0x10568adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105758be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:00:50 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:00:50 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:00:50 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:00:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:50 INFO - Return code: 0 19:00:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:00:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:00:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:00:50 INFO - ENV: RUST_BACKTRACE is now 1 19:00:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:00:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:00:50 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/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0068', '--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:00:50 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/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0068 --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:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OgtL1Aak7J/Render', 19:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:00:50 INFO - 'HOME': '/Users/cltbld', 19:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:00:50 INFO - 'LOGNAME': 'cltbld', 19:00:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:00:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:50 INFO - 'MOZ_NO_REMOTE': '1', 19:00:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:00:50 INFO - 'NO_EM_RESTART': '1', 19:00:50 INFO - 'PAGER': '/bin/cat', 19:00:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:50 INFO - 'PWD': '/builds/slave/test', 19:00:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:00:50 INFO - 'RUST_BACKTRACE': '1', 19:00:50 INFO - 'SHELL': '/bin/bash', 19:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YIaIioRgyZ/Listeners', 19:00:50 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 19:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:00:50 INFO - 'USER': 'cltbld', 19:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:50 INFO - 'XPC_FLAGS': '0x0', 19:00:50 INFO - 'XPC_SERVICE_NAME': '0', 19:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:00:50 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/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0068', '--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:00:51 INFO - mozversion application_buildid: 20170331174923 19:00:51 INFO - mozversion application_changeset: 00a166a8640dffa2e0f48650f966d75ca3c1836e 19:00:51 INFO - mozversion application_display_name: Nightly 19:00:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:51 INFO - mozversion application_name: Firefox 19:00:51 INFO - mozversion application_remotingname: firefox 19:00:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:00:51 INFO - mozversion application_vendor: Mozilla 19:00:51 INFO - mozversion application_version: 55.0a1 19:00:51 INFO - mozversion platform_buildid: 20170331174923 19:00:51 INFO - mozversion platform_changeset: 00a166a8640dffa2e0f48650f966d75ca3c1836e 19:00:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:00:51 INFO - mozversion platform_version: 55.0a1 19:00:51 INFO - using testdate: 1491012051 19:00:51 INFO - actual date: 1491012051 19:00:51 INFO - starting webserver on 'localhost:49301' 19:00:51 INFO - SUITE-START | Running 2 tests 19:00:51 INFO - TEST-START | dromaeo_css 19:00:51 INFO - operating with platform_type : mac_ 19:00:51 INFO - Initialising browser for dromaeo_css test... 19:00:51 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpy0iub0/profile http://localhost:49301/getInfo.html) 19:00:54 INFO - PID 1997 | __metrics Screen width/height:1600/1200 19:00:54 INFO - PID 1997 | colorDepth:24 19:00:54 INFO - PID 1997 | Browser inner width/height: 1024/689 19:00:54 INFO - PID 1997 | __metrics 19:00:54 INFO - PID 1997 | 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:00:54 INFO - PID 1997 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:00:54 INFO - TEST-INFO | 1997: exit 0 19:00:54 INFO - Browser initialized. 19:00:54 INFO - Running cycle 1/1 for dromaeo_css test... 19:00:54 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpy0iub0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:01:06 INFO - PID 2000 | RSS: Main: 233984000 19:01:06 INFO - PID 2000 | 19:04:12 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49301/tests/dromaeo/cssquery-ext.html) 19:04:14 INFO - PID 2000 | RSS: Main: 425734144 19:04:14 INFO - PID 2000 | 19:05:56 INFO - PID 2000 | ************************* 19:05:56 INFO - PID 2000 | A coding exception was thrown and uncaught in a Task. 19:05:56 INFO - PID 2000 | 19:05:56 ERROR - PID 2000 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:05:56 INFO - PID 2000 | Full stack: 19:05:56 INFO - PID 2000 | ************************* 19:05:56 INFO - PID 2000 | ************************* 19:05:56 INFO - PID 2000 | A coding exception was thrown and uncaught in a Task. 19:05:56 INFO - PID 2000 | 19:05:56 ERROR - PID 2000 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:05:56 INFO - PID 2000 | Full stack: 19:05:56 INFO - PID 2000 | ************************* 19:05:56 INFO - PID 2000 | ************************* 19:05:56 INFO - PID 2000 | A coding exception was thrown and uncaught in a Task. 19:05:56 INFO - PID 2000 | 19:05:56 ERROR - PID 2000 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:05:56 INFO - PID 2000 | Full stack: 19:05:56 INFO - PID 2000 | ************************* 19:05:56 INFO - PID 2000 | ************************* 19:05:56 INFO - PID 2000 | A coding exception was thrown and uncaught in a Task. 19:05:56 INFO - PID 2000 | 19:05:56 ERROR - PID 2000 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:05:56 INFO - PID 2000 | Full stack: 19:05:56 INFO - PID 2000 | ************************* 19:07:17 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-ext.html (next: http://localhost:49301/tests/dromaeo/cssquery-jquery.html) 19:07:18 INFO - PID 2000 | RSS: Main: 357736448 19:07:18 INFO - PID 2000 | 19:10:20 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49301/tests/dromaeo/cssquery-mootools.html) 19:10:20 INFO - PID 2000 | RSS: Main: 339447808 19:10:20 INFO - PID 2000 | 19:13:23 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49301/tests/dromaeo/cssquery-prototype.html) 19:13:23 INFO - PID 2000 | RSS: Main: 339587072 19:13:23 INFO - PID 2000 | 19:16:27 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49301/tests/dromaeo/cssquery-yui.html) 19:16:28 INFO - PID 2000 | RSS: Main: 348315648 19:16:28 INFO - PID 2000 | 19:19:31 INFO - PID 2000 | Cycle 1(1): loaded http://localhost:49301/tests/dromaeo/cssquery-yui.html (next: http://localhost:49301/tests/dromaeo/cssquery-dojo.html) 19:19:32 INFO - PID 2000 | RSS: Main: 600133632 19:19:32 INFO - PID 2000 | 19:19:32 INFO - PID 2000 | __start_tp_report 19:19:32 INFO - PID 2000 | _x_x_mozilla_page_load 19:19:32 INFO - PID 2000 | _x_x_mozilla_page_load_details 19:19:32 INFO - PID 2000 | |i|pagename|runs| 19:19:32 INFO - PID 2000 | |0;dojo.html;3256.9511457328135;3475.2528206435613;3481.4255647818113;3492.7205823534114;3515.4023815951286;5959.940400595992;6103.816885493431;6137.263528376601;6139.938600613992;6158.753649854;6085.087236914465;6102.847428814271;6112.655464441472;6118.284172697665;6151.292601350846;5177.922331165036;5311.575073994071;5352.063388906945;5372.274742909696;5406.189071639266;5448.073827449323;5479.835604931858;5492.862678433051;5493.862653433676;5532.640378375413;5248.0553500369915;5317.46825317469;5328.227407025959;5341.359036915556;5425.159100339473;5385.21914322425;5388.703621300827;5411.972940135274;5440.265564148829;5469.507744303032;5332.226827110047;5359.624826262163;5370;5373.677579345252;5413.323334583177;5976.402359764033;6034.547408944347;6137.78517751881;6142.385761423867;6170.19787427636;6379.425851673372;6391.233052033739;6392.4246817786625;6396.0725694774;6429.132067170919;5590.804321848756;6627.701753421107;6694.531382803206;6696.665166741692;6698.162729658793;6146.877062458726;6171.907421388682;6239.906401403937;6241.531885108635;6264.248290205204;6835.179778426621;6842.93157068423;6850.177978642595;6860.485463590251;6865.210500792373;6205.875882482415;6307.432331090132;6384.297727249998;6481.4166724994975;6558.344165583499;6553.442957348583;6603.867922641521;6606.735730570819;6622.768203112964;6625.734970601218;6510.576812507172;6515.087887695727;6520.315366886503;6525.673716314261;6531.934680653228;6277.340879207617;6377.936220637735;6383.234011918599;6539.411452969255;6555;5237.790488380499;5239.580833533309;5253.290805741252;5255.343082114736;5255.921161182585;4609.654275929319;4718.2214934536105;4723.220668589713;4734.171519984058;4749.881252968704;5064.594832413398;6101.429060711456;6134.938650613526;6155.169052177988;6156.661383623854;6396.616203027833;6501.252355979028;6598.47212223021;6629.370209830058;6630.83422914431;6254.405831446005;6262.6868656566985;6271.6550589718;6277.843053923689;6286.654234017173;5842.036064049385;5847.766089356378;5848.298204215522;5861.17943487912;5915;6533.18335208099;6638.137042184485;6639.103720997797;6707.731690732316;6815.454763618898;5464.972675136599;5686.2607860977805;6525.543211975116;6575.572587781779;6611.239707433514;6459.4832413405875;6506.25178104524;6617.272100069084;6817.045613613999;6832.59004459734;6434.613923164625;6529.902051469327;6532.281449040506;6540.476761859135;6549.934500654933;6300.621962682254;6408.487321014401;6621.238557565942;6623.933760662332;6625.602463852184;6205.751769929333;6215.751369945152;6227.719752611234;6244.1570387997035;6334.208223972004;5277.551408130198;6397.456216221487;6417.069524918954;6432.35676432353;6432.935670643234;6284.811455656338;6293.842653933505;6302.464290535172;6306.873862522815;6316.62100273985;6333.524985626189;6434.903476447951;6438.323975982642;6454.5159113065765;6460.644664543495;6128.717018009172;6226.097215903759;6229.875402492015;6230.221222347207;6233.781817636361 19:19:32 INFO - PID 2000 | |1;ext.html;798.4371018432006;819.1644522586962;1069.3370110531466;1092.9398883061428;1093.9015488606024;37237.627623723754;38005.80997095014;38169.80915095421;38217.80891095548;38386;40256.59743402565;40702;40708;40806.59193408065;40810.571629992955;6184.412480814338;6338.30278669346;8617.612207450664;8783.736487905373;8796;8501.744947651581;8702.260307873807;8720.651173953034;8728.869066964;8739.912600874006;8745.344099192585;8812.647494100229;8815.77960550985;8826.117388261187;8827.16141966512;8719.346049046315;8786.956065219696;8791.164839340252;8802.471851688919;8806.911930880673;8569.914300856974;8577.228049475578;8622.870656940151;8623.698170564063;8631.136886311382;38684;38934.80532597319;38948.415773763416;38956.61043389587;38999.805000975095;2506.987465062681;2956.4382767274365;2978.3447641519047;2979.06159559738;3027.2129246395875;22079;27347.589786153225;27487.876818477387;27983.72016279852;28298.434031319463;2795.259256297083;2830.8584570771377;2863.8568071596337;2864.298246929495;2867.3978464522265;349747;352839;354283;355066.2246688776;355243.2237838794;40312.59687403088;41409.96475088147;41433.378499322534;52355;52850;44734.88162795891;44794.77602611966;52145.95708085817;52348.95302093937;53220;14118.50585229512;14531.491397801026;14880.776788348183;14895.70208595822;14897.851021489647;12027.75944481123;12147;12170.57402990891;12170.878291216974;12173.513059477522;13734.244616546186;13755.17468951866;13776.03567750248;13847.961402894622;13956;5789.2763404574425;5806.593538452352;5850.2102216200265;5852;5862.501687356537;825.3562221467265;979.7893452907659;995.785906030207;1004.2468148888333;1018.6383833739064;22868.771312286997;23573.7642623575;24285.7571424287;24448.266552003468;24450.188228353967;1076.6285631457135;1084.2139448899484;1101.735583459964;1116.905063069632;1120.5181771838024;11789.823152652718;12468.376581170905;12505;12565.18326308787;12571.102958083024;459855;462163;463302;463432;464520;55821.720891395285;56248;56253.593660158;56258;56516.43483565112;1451.0930668332292;1475.2033901692967;1518.916459594733;1519.8252200996806;1529.8699610533229;21368.82471464022;21992.89003554972;23819.312018623405;24062.25000372632;24182.911768970087;40379.394309085976;40383.990400240225;40430.39354409745;40464.1907161861;40494.392584111854;432714;433309;434030;434755;435243;26726;30841.537376939814;34753.478697819046;34790.47814282838;34802.30395392027;42952.92617684583;43342.69971900848;43444;43782;43826;23596.938137783498;27861;28392.148235552966;30224.94212702545;30728.539071914387;28955.98654047098;29115.563266550595;29862.954796582017;30050.549241760953;30176.24559386033;34274.65725342715;35544.644553554135;35644.28711425809;35848;38557.807210963765;38326;38787.6121238784;39649.008774780865;39649.04386951631;39980.400293996194;28713;30355.544666829574;30585.011974221605;31404.685953140175;31555.322286371433 19:19:32 INFO - PID 2000 | |2;jquery.html;383.721801693772;422.48245898773985;424.12418356094645;435.7385568658805;440.9184300904332;19861.70898891571;21246.681299780495;21982;22108.784016879104;22143;21424.714517128985;22454.775452245474;23002;23201.535969280605;23276.301710948657;6097.939020609803;6388.4889208863415;6393.009083592027;6394.040893865911;6409.070684750708;5951.6726580038085;6296.905546416808;6372.490200783926;6375.521835862306;6400.167978162833;6082.270127584674;6328.936710632904;6339.302676705559;6348.968255158741;6354.586951848139;6158.784442544512;6263.31103578606;6291.1506946562085;6315.210598675166;6329;5365.382980957201;5553.805616803433;5597.580181486404;5603.8879222415735;5627.5779316551425;27000.45999080027;27065.86467067652;27090.5936410954;27202;27505.449891002267;2041.4794227472048;2044.928427505045;2055.486128467883;2058.87646741196;2106.1154315187505;15550.844491555054;16011.919940400223;16269.105199214038;16571.83428165715;16927.238274277686;1865.7947625761155;1877.1458986161265;1883.8210370014826;1894.280173534062;1917.836983856374;137673;142333.2883335587;142653;143044.2847785775;145386;11215;11890.464929078213;12073.577424790266;12076.818847717292;12328.780819452584;13441.462341506425;15941.804364672696;16163.272652730655;16212.35150593963;16254.349826006828;8597.441166324168;8792.42849214799;8811.55016716567;8866.556672166365;8943.865842012376;8427.662893484314;8448.07071222165;8449.95775021121;8574.528400937883;8638.13618638131;7483.2516748325825;7615.581143037186;7658.502197357154;7678.385729141655;7693.230676932262;1901.3630433804553;2059.124871929454;2071.0576687607104;2074.1703318672653;2081.469225347527;914.4239129348468;953.1993125774383;967.1150896929231;985.408754747146;993.7267251505893;19019;19146.617067658848;20759.68860467094;20878.060487278108;21222.045007974677;967.8741763570831;972.3290929258789;1001.8196724589498;1002.2583288366557;1004.4776716107583;9908.405495670282;10105.271576674257;10385.376877387382;10538.420386878643;10568.894311056945;672668;673572;679407;680182;700610;151105.24447377914;159968;160592;161968.1901590508;162053.98433164583;1143.822707480342;1173.0791328807015;1202.7895118354254;1203.9699007524882;1204.1209916760638;17631.559211019827;17883.821161788215;17896;18005.639887202444;18024.549386265448;61226.38773612385;61753.073703895374;62731.74083867452;62949.37050629435;64207;86452.70320945066;88634.11365886258;89323.55012561967;89822;90322.64516032397;8717.128287171232;8726.781830454289;8823.779405514657;8843.778905527413;8881.911180888108;13512.6621834451;13641.522546710818;13696.315184240948;14153.43386264538;14177.503787367392;11805.822912656145;11842.881571184178;12001.219920705125;12136.696582585506;12173.634790956285;10956.452177391258;10997.780044398907;11289.379084150121;11361.659150225507;11377.2604780689;11606.187566870238;11617.535298587962;12034.578789742318;12069.75860482803;12078.818817717916;8357.122502137188;8484.618192181244;8548.187922147386;8848.778780530538;9031.96780724358;11239.831402528805;11425.828612570984;11817.054635629302;11862.406879656155;12023.579174728842 19:19:32 INFO - PID 2000 | |3;mootools.html;1155.1394211312563;1329.381837445588;1379.3448112146732;1393.3520912775562;1404.6067101211659;9268.907310926897;9622;10679.519421626026;10992;10999.61501347453;10566.788664226711;10665.946670266658;10679;10679.252452328341;10714.78570428591;2033.5627840014395;2079.918442409946;2085.967446114176;2087.373787863635;2088.0916801191456;2065.535254567725;2150.8171805396482;2372.774586414288;2458.1273647855023;2469.987650061747;2018.8384929205702;2393.724721657006;2429.149797570854;2433.0267892842917;2439.621858611918;2378.7740164684415;2385.5467461182407;2415.625578035407;2416.0698131219433;2422.2733180046093;2193.429708275844;2347.976520234793;2382.4996750682203;2391.820613453998;2423.164008417093;10713.464326783629;10771.246012779031;10809.297395669335;10894.891051089468;10922.508487118099;6085.452309292141;6314.989601663712;6328.272248691414;6332.525060620425;6339.936600633981;3796.6583007529457;4058.2086493133556;4106.055607210328;4111.938320925188;4116.9794151029355;1109.4896347679996;1165.6561314412268;1177.0877569883323;1215.2708374975032;1216.5255550335376;15291.923540382339;15418.537443876701;15505.302261398265;15514.922425387913;15515.844841551552;5370.140777475585;5619.241402410622;5626.718664066781;5644.068728659725;5732.570057245724;12570.994320454342;12595.622131336075;12604.180728252633;12606.306653133983;12617;6354.714037868307;6356.745730170834;6360.395762402564;6360.618362898241;6367.395097465734;5437.537809286255;5682.374938756733;5760.481556659921;5789.044807606782;5790.305163380422;3824.598417166213;3924.6664033557468;4215.831366745296;4268.978655106766;4300.65594752419;1242.8570714367963;1252.3300034481508;1262.2489618676873;1269.1243042300782;1270.803025531044;743.3792783026233;746.9551826890404;765.6286700950035;767.5778321923032;807.3258828877953;5832.941670583325;6283.560150789493;6467.676616169173;6516.706748196342;6614.0740296358545;870.1472556894279;909.1408618855119;914.9039350868063;919.852823548229;928.9674861379955;3848.461215429842;4007.73949693269;4120.979395103005;4124.711270211116;4195.265828480004;13486.86513134856;14052.297385130703;14067.085639433404;14098.577042688736;14105.435782568582;13348.332583370986;13899.16605003703;13995.720085598232;14025.298735063207;14041.946853985992;8288.461250018729;9806.852897206547;10071.446070466049;10080.495975201211;10106.39361638304;5672.12082127271;6296.5277604178955;6521.836954076186;6759.932400675931;6786.626735529593;12223.327716975651;12593.118481706559;12598.748025039631;12611.558595449114;12713.618591442271;11227;13002.219866808022;13032.739345212853;13032.934835325763;13032.934835325763;8838.823223535623;9184.311176661644;9190.49452280131;9197.540122993958;9202.769930751785;8393.622286996977;10020;10087.445190514592;10180.389176649425;10240.590376384862;8547.059823419544;8550.144985501649;8615.91384086151;8867.290616750515;8882.644694212158;8384.622691978753;8500.107488713844;8545.82908341842;8608.268297194558;8666.523341216294;7583.886241706489;7654.196309387434;7679.040119985002;7727.768166955;7748.457607967388;5346.438623944586;5806.158107074535;5829.970850145722;5868.530517558671;5985.25184351956;5830.47525722687;5933.9109913352195;5951.642901425928;5957.49361304294;6036.3661815510495 19:19:32 INFO - PID 2000 | |4;prototype.html;384.1721091048791;387.3840593456405;394.41232563480423;395.55302508165767;400.6334204203154;5648.181013753004;5914.8225553233415;6149.969250153743;6150.538709596775;6156.5690401671845;4581.793819278132;5510.090835012228;5548.44515548445;5911.453128123124;6010.248718910137;3763.623637636228;4210.915781684364;4423.672898130564;4605.240135377659;4605.493395726484;3760.417135344026;3953;4643.303504474339;4651.8837029074375;4670.76646167692;3376.9906905391254;4582.954170458286;4583.404157459542;4622.168009758242;4654.720716757005;4561.29299958507;4566.794494247767;4567.862964111082;4574.199515084847;4613.584777370036;3158.4472717274616;3712.6844218241213;4060.9187816243807;4061;4084.244414783245;5066.518680725325;5556.583256255797;5626.508975121596;5789.623674461147;5903.468687818074;5412.755066334726;5463.16983810424;5471.863203419946;5480.725963701799;5515.641483303612;6446;6451.83870403239;6455.451286640641;6457.547971641987;6475.248019591655;4480.663950203715;4565.223911934946;4604.102200070987;4619.353290539327;4632.2125238709505;6514.771982980573;6669.833254168636;6709.899351509731;6725.764598239087;6726.495512836557;4600.631949444103;4710.26990816424;4725.298892398734;4742.549457801503;4757.666963312535;4009.3785463253244;4274.952636604052;4809.975950120227;4815.422149342101;4822.517748225149;4761.023990082025;4864.683795553277;5179.430262671103;5383.380911195262;5479.835604931858;6159.260888693386;6485.4163125318;6506.609603423715;6520.576162549419;6527.89924785723;1444.6966137111324;1447.334226255934;1507.5100592307545;1647.983520164783;1650.6946214950033;876.3996662286227;987.0425687083517;991.613270824379;1005.6480231918916;1014.3102690170755;6012.909806352908;6154.5384096192065;6156.953317935961;6162.476189523851;6163.705621819378;6061.363556826558;6616.636085015371;6639.734410623521;6645.734170633121;6668.733250670016;5342.439043900412;6149.938500614937;6168.475679567197;6212.565120441525;6245.375462453719;2921.576371426131;3474.4614584739406;3477.200243943907;3481.303739252109;3496.9825150874085;6569.704363303663;6850.417714494324;6875.828104297432;6898.551594146365;6929.930700692928;5609.80365687199;5950.7917222896995;6842.93157068423;6851.725930962805;6852.211995620468;6058.848528786815;6394.776182833579;6892.276310987374;6911;6916.827079323057;6078.939210608014;6631.867362652816;6634.502412318999;6670.7665231716655;6693.19681638187;6120.969395152996;6331.27190373113;6574.309697481887;6586.901196481961;6645.568038077703;6110.388961103854;6434.195725534309;6752.459803215829;6818.897716534355;6898.965505172442;4315.913681726411;4385.627221686193;4396.626286765661;4404.55954404557;4421.977890110529;6076.817695469143;6417.93582064192;6596.60420374779;6674.866502670016;6695.163104611924;6124.5712800103565;6391.776287829904;6440.9033864493;6467.514936379885;6498.610083395011;6138.969305153446;6412.294647588855;6422.710978006095;6428.19647544057;6483.157189565326;5645.576581756467;5746.879358525048;6351.460125889351;6352.428281454691;6370.58591191571;5499.120140777456;6186.391538200191;6361.236651601837;6449.6130232186215;6456.515761317826;6253.468455181179;6260.342664020212;6268.52986026059;6287.96856015717;6338.559654532945 19:19:32 INFO - PID 2000 | |5;yui.html;710.955538086551;728.0389885351336;728.2062551818517;734.247396418671;745.3962290544656;15866.682666346665;16126.596835079128;16172.433964811205;16234.594135146612;16235.918820405881;12738.745225095492;14380.568582942502;14795.40818367264;14969.550913472585;15077.62305942352;955.0926619711285;971.6744890461704;973.630020592174;983.0562659846556;1006.6023920551414;972.0182615558301;980.446047982891;987.4322264697792;989.4113002763344;990.2919412619975;1046.6232156423682;1050.2543194332034;1051.2378525568977;1052.5368837711383;1053.183782568508;1033.689893032091;1034.7257976636197;1034.8602938603306;1037.2013549566866;1038.8857225705167;771.5023809642805;772.1660606544974;772.4785769605494;773.2190487607501;773.3078894389546;14089.64775880601;16625.334986600523;16635.916820415943;16704.498865034067;16898.493045208663;14615.123092614476;14753.70492590153;14781.26093695311;14864.62838429037;14905.031172973722;11697.649070527897;11723.15613513825;12030.458629361612;12235.082368822374;12261.448234829364;2901.289184149876;2982.164993801717;3074.123874695701;3103.2552187474844;3105.378924215166;109028;110832;111189;113438;116079.41960290144;11342.60300889465;11618.94190529042;11637.76724465523;11954.521819127138;12004.699882502833;25258.621120683205;25451.23646290614;25454.363640909127;25515.36211594725;25520.489590208093;7712.113106992655;7751.496152750054;7892.210778922062;7950;8153.714619988272;4069.5726948670554;4094.8157332919495;4114;4114.382842573578;4189.916201675949;4127.380892866034;4199.097194103282;4232.957670423257;4238.766867822238;4446.088551846864;854.7008547008621;864.7967727584013;870.5821205821114;874.3660845886808;874.7200895713438;531.9388270348959;545.7898708996985;548.7695168029437;565.8613639658311;573.2576313673719;9835.459049752333;9948.321058544501;9978.700638980843;10558.855197804742;10847.783044339227;516.4293455731438;557.8103444828778;568.7260536398438;573.057320707434;577.8150991682621;4036.253293140778;4407.294832826732;4449.638185985879;4493.865184044484;4750.8337208197545;102632;105139;106284;107258;108985.45507272413;93862;94670;95395.56906646406;97511.51244243734;97868.51065744768;79163.60418197872;79851;81017.59491202506;81453;81588;7900.723474678359;8669.696560620348;9255.444673319622;9294.907050929403;9317.767055823659;33174.502382464765;34382.280885956105;35329.470057949664;37816.43275350927;39698.206035879695;51517;65441;66028.33971660222;67020.66489667521;69377.65311173412;12045.81931271014;13692.05116172258;13782.313196340774;14063;14330;14055.718885622025;14288.829418178297;14334.856651433769;14356.353964071433;14362.281885905453;13169.275689836768;13307.467701292228;13329;13338.533151339656;13435.328233588478;13042.347882606022;13141;13271.800922986356;13300.268485233406;13387.330633468482;12430.627081187216;12499.500059992859;12722.491100355883;12770.23378597287;13221.338933053117;8733.737987860375;9277.536123193948;9541.427514349161;9748.9025109748;10349.586016559253;8393.365140675412;10335.22485813582;10756.193285503463;11136.888631113585;11232.66302010941 19:19:32 INFO - PID 2000 | __end_tp_report 19:19:32 INFO - PID 2000 | __start_cc_report 19:19:32 INFO - PID 2000 | _x_x_mozilla_cycle_collect,2172 19:19:32 INFO - PID 2000 | __end_cc_report 19:19:32 INFO - PID 2000 | __startTimestamp1491013172001__endTimestamp 19:19:32 INFO - PID 2000 | 19:19:32 INFO - PID 2000 | ------- Summary: start ------- 19:19:32 INFO - PID 2000 | Number of tests: 6 19:19:32 INFO - PID 2000 | 19:19:32 INFO - PID 2000 | [#0] dojo.html Cycles:165 Average:6030.29 Median:6244.16 stddev:697.85 (11.2%) stddev-sans-first:665.22 19:19:32 INFO - PID 2000 | Values: 3257.0 3475.3 3481.4 3492.7 3515.4 5959.9 6103.8 6137.3 6139.9 6158.8 6085.1 6102.8 6112.7 6118.3 6151.3 5177.9 5311.6 5352.1 5372.3 5406.2 5448.1 5479.8 5492.9 5493.9 5532.6 5248.1 5317.5 5328.2 5341.4 5425.2 5385.2 5388.7 5412.0 5440.3 5469.5 5332.2 5359.6 5370.0 5373.7 5413.3 5976.4 6034.5 6137.8 6142.4 6170.2 6379.4 6391.2 6392.4 6396.1 6429.1 5590.8 6627.7 6694.5 6696.7 6698.2 6146.9 6171.9 6239.9 6241.5 6264.2 6835.2 6842.9 6850.2 6860.5 6865.2 6205.9 6307.4 6384.3 6481.4 6558.3 6553.4 6603.9 6606.7 6622.8 6625.7 6510.6 6515.1 6520.3 6525.7 6531.9 6277.3 6377.9 6383.2 6539.4 6555.0 5237.8 5239.6 5253.3 5255.3 5255.9 4609.7 4718.2 4723.2 4734.2 4749.9 5064.6 6101.4 6134.9 6155.2 6156.7 6396.6 6501.3 6598.5 6629.4 6630.8 6254.4 6262.7 6271.7 6277.8 6286.7 5842.0 5847.8 5848.3 5861.2 5915.0 6533.2 6638.1 6639.1 6707.7 6815.5 5465.0 5686.3 6525.5 6575.6 6611.2 6459.5 6506.3 6617.3 6817.0 6832.6 6434.6 6529.9 6532.3 6540.5 6549.9 6300.6 6408.5 6621.2 6623.9 6625.6 6205.8 6215.8 6227.7 6244.2 6334.2 5277.6 6397.5 6417.1 6432.4 6432.9 6284.8 6293.8 6302.5 6306.9 6316.6 6333.5 6434.9 6438.3 6454.5 6460.6 6128.7 6226.1 6229.9 6230.2 6233.8 19:19:32 INFO - PID 2000 | 19:19:32 INFO - PID 2000 | [#1] ext.html Cycles:180 Average:55117.28 Median:38087.81 stddev:111278.27 (292.2%) stddev-sans-first:111515.70 19:19:32 INFO - PID 2000 | Values: 798.4 819.2 1069.3 1092.9 1093.9 37237.6 38005.8 38169.8 38217.8 38386.0 40256.6 40702.0 40708.0 40806.6 40810.6 6184.4 6338.3 8617.6 8783.7 8796.0 8501.7 8702.3 8720.7 8728.9 8739.9 8745.3 8812.6 8815.8 8826.1 8827.2 8719.3 8787.0 8791.2 8802.5 8806.9 8569.9 8577.2 8622.9 8623.7 8631.1 38684.0 38934.8 38948.4 38956.6 38999.8 2507.0 2956.4 2978.3 2979.1 3027.2 22079.0 27347.6 27487.9 27983.7 28298.4 2795.3 2830.9 2863.9 2864.3 2867.4 349747.0 352839.0 354283.0 355066.2 355243.2 40312.6 41410.0 41433.4 52355.0 52850.0 44734.9 44794.8 52146.0 52349.0 53220.0 14118.5 14531.5 14880.8 14895.7 14897.9 12027.8 12147.0 12170.6 12170.9 12173.5 13734.2 13755.2 13776.0 13848.0 13956.0 5789.3 5806.6 5850.2 5852.0 5862.5 825.4 979.8 995.8 1004.2 1018.6 22868.8 23573.8 24285.8 24448.3 24450.2 1076.6 1084.2 1101.7 1116.9 1120.5 11789.8 12468.4 12505.0 12565.2 12571.1 459855.0 462163.0 463302.0 463432.0 464520.0 55821.7 56248.0 56253.6 56258.0 56516.4 1451.1 1475.2 1518.9 1519.8 1529.9 21368.8 21992.9 23819.3 24062.3 24182.9 40379.4 40384.0 40430.4 40464.2 40494.4 432714.0 433309.0 434030.0 434755.0 435243.0 26726.0 30841.5 34753.5 34790.5 34802.3 42952.9 43342.7 43444.0 43782.0 43826.0 23596.9 27861.0 28392.1 30224.9 30728.5 28956.0 29115.6 29863.0 30050.5 30176.2 34274.7 35544.6 35644.3 35848.0 38557.8 38326.0 38787.6 39649.0 39649.0 39980.4 28713.0 30355.5 30585.0 31404.7 31555.3 19:19:32 INFO - PID 2000 | 19:19:32 INFO - PID 2000 | [#2] jquery.html Cycles:180 Average:40023.99 Median:22045.39 stddev:114395.25 (518.9%) stddev-sans-first:114677.43 19:19:32 INFO - PID 2000 | Values: 383.7 422.5 424.1 435.7 440.9 19861.7 21246.7 21982.0 22108.8 22143.0 21424.7 22454.8 23002.0 23201.5 23276.3 6097.9 6388.5 6393.0 6394.0 6409.1 5951.7 6296.9 6372.5 6375.5 6400.2 6082.3 6328.9 6339.3 6349.0 6354.6 6158.8 6263.3 6291.2 6315.2 6329.0 5365.4 5553.8 5597.6 5603.9 5627.6 27000.5 27065.9 27090.6 27202.0 27505.4 2041.5 2044.9 2055.5 2058.9 2106.1 15550.8 16011.9 16269.1 16571.8 16927.2 1865.8 1877.1 1883.8 1894.3 1917.8 137673.0 142333.3 142653.0 143044.3 145386.0 11215.0 11890.5 12073.6 12076.8 12328.8 13441.5 15941.8 16163.3 16212.4 16254.3 8597.4 8792.4 8811.6 8866.6 8943.9 8427.7 8448.1 8450.0 8574.5 8638.1 7483.3 7615.6 7658.5 7678.4 7693.2 1901.4 2059.1 2071.1 2074.2 2081.5 914.4 953.2 967.1 985.4 993.7 19019.0 19146.6 20759.7 20878.1 21222.0 967.9 972.3 1001.8 1002.3 1004.5 9908.4 10105.3 10385.4 10538.4 10568.9 672668.0 673572.0 679407.0 680182.0 700610.0 151105.2 159968.0 160592.0 161968.2 162054.0 1143.8 1173.1 1202.8 1204.0 1204.1 17631.6 17883.8 17896.0 18005.6 18024.5 61226.4 61753.1 62731.7 62949.4 64207.0 86452.7 88634.1 89323.6 89822.0 90322.6 8717.1 8726.8 8823.8 8843.8 8881.9 13512.7 13641.5 13696.3 14153.4 14177.5 11805.8 11842.9 12001.2 12136.7 12173.6 10956.5 10997.8 11289.4 11361.7 11377.3 11606.2 11617.5 12034.6 12069.8 12078.8 8357.1 8484.6 8548.2 8848.8 9032.0 11239.8 11425.8 11817.1 11862.4 12023.6 19:19:32 INFO - PID 2000 | 19:19:32 INFO - PID 2000 | [#3] mootools.html Cycles:180 Average:6774.52 Median:3810.63 stddev:4246.88 (111.4%) stddev-sans-first:4237.79 19:19:32 INFO - PID 2000 | Values: 1155.1 1329.4 1379.3 1393.4 1404.6 9268.9 9622.0 10679.5 10992.0 10999.6 10566.8 10665.9 10679.0 10679.3 10714.8 2033.6 2079.9 2086.0 2087.4 2088.1 2065.5 2150.8 2372.8 2458.1 2470.0 2018.8 2393.7 2429.1 2433.0 2439.6 2378.8 2385.5 2415.6 2416.1 2422.3 2193.4 2348.0 2382.5 2391.8 2423.2 10713.5 10771.2 10809.3 10894.9 10922.5 6085.5 6315.0 6328.3 6332.5 6339.9 3796.7 4058.2 4106.1 4111.9 4117.0 1109.5 1165.7 1177.1 1215.3 1216.5 15291.9 15418.5 15505.3 15514.9 15515.8 5370.1 5619.2 5626.7 5644.1 5732.6 12571.0 12595.6 12604.2 12606.3 12617.0 6354.7 6356.7 6360.4 6360.6 6367.4 5437.5 5682.4 5760.5 5789.0 5790.3 3824.6 3924.7 4215.8 4269.0 4300.7 1242.9 1252.3 1262.2 1269.1 1270.8 743.4 747.0 765.6 767.6 807.3 5832.9 6283.6 6467.7 6516.7 6614.1 870.1 909.1 914.9 919.9 929.0 3848.5 4007.7 4121.0 4124.7 4195.3 13486.9 14052.3 14067.1 14098.6 14105.4 13348.3 13899.2 13995.7 14025.3 14041.9 8288.5 9806.9 10071.4 10080.5 10106.4 5672.1 6296.5 6521.8 6759.9 6786.6 12223.3 12593.1 12598.7 12611.6 12713.6 11227.0 13002.2 13032.7 13032.9 13032.9 8838.8 9184.3 9190.5 9197.5 9202.8 8393.6 10020.0 10087.4 10180.4 10240.6 8547.1 8550.1 8615.9 8867.3 8882.6 8384.6 8500.1 8545.8 8608.3 8666.5 7583.9 7654.2 7679.0 7727.8 7748.5 5346.4 5806.2 5830.0 5868.5 5985.3 5830.5 5933.9 5951.6 5957.5 6036.4 19:19:32 INFO - PID 2000 | 19:19:32 INFO - PID 2000 | [#4] prototype.html Cycles:180 Average:5254.50 Median:6035.88 stddev:1626.66 (26.9%) stddev-sans-first:1589.61 19:19:32 INFO - PID 2000 | Values: 384.2 387.4 394.4 395.6 400.6 5648.2 5914.8 6150.0 6150.5 6156.6 4581.8 5510.1 5548.4 5911.5 6010.2 3763.6 4210.9 4423.7 4605.2 4605.5 3760.4 3953.0 4643.3 4651.9 4670.8 3377.0 4583.0 4583.4 4622.2 4654.7 4561.3 4566.8 4567.9 4574.2 4613.6 3158.4 3712.7 4060.9 4061.0 4084.2 5066.5 5556.6 5626.5 5789.6 5903.5 5412.8 5463.2 5471.9 5480.7 5515.6 6446.0 6451.8 6455.5 6457.5 6475.2 4480.7 4565.2 4604.1 4619.4 4632.2 6514.8 6669.8 6709.9 6725.8 6726.5 4600.6 4710.3 4725.3 4742.5 4757.7 4009.4 4275.0 4810.0 4815.4 4822.5 4761.0 4864.7 5179.4 5383.4 5479.8 6159.3 6485.4 6506.6 6520.6 6527.9 1444.7 1447.3 1507.5 1648.0 1650.7 876.4 987.0 991.6 1005.6 1014.3 6012.9 6154.5 6157.0 6162.5 6163.7 6061.4 6616.6 6639.7 6645.7 6668.7 5342.4 6149.9 6168.5 6212.6 6245.4 2921.6 3474.5 3477.2 3481.3 3497.0 6569.7 6850.4 6875.8 6898.6 6929.9 5609.8 5950.8 6842.9 6851.7 6852.2 6058.8 6394.8 6892.3 6911.0 6916.8 6078.9 6631.9 6634.5 6670.8 6693.2 6121.0 6331.3 6574.3 6586.9 6645.6 6110.4 6434.2 6752.5 6818.9 6899.0 4315.9 4385.6 4396.6 4404.6 4422.0 6076.8 6417.9 6596.6 6674.9 6695.2 6124.6 6391.8 6440.9 6467.5 6498.6 6139.0 6412.3 6422.7 6428.2 6483.2 5645.6 5746.9 6351.5 6352.4 6370.6 5499.1 6186.4 6361.2 6449.6 6456.5 6253.5 6260.3 6268.5 6288.0 6338.6 19:19:32 INFO - PID 2000 | 19:19:32 INFO - PID 2000 | [#5] yui.html Cycles:180 Average:20629.12 Median:3088.69 stddev:30326.76 (981.9%) stddev-sans-first:30374.95 19:19:32 INFO - PID 2000 | Values: 711.0 728.0 728.2 734.2 745.4 15866.7 16126.6 16172.4 16234.6 16235.9 12738.7 14380.6 14795.4 14969.6 15077.6 955.1 971.7 973.6 983.1 1006.6 972.0 980.4 987.4 989.4 990.3 1046.6 1050.3 1051.2 1052.5 1053.2 1033.7 1034.7 1034.9 1037.2 1038.9 771.5 772.2 772.5 773.2 773.3 14089.6 16625.3 16635.9 16704.5 16898.5 14615.1 14753.7 14781.3 14864.6 14905.0 11697.6 11723.2 12030.5 12235.1 12261.4 2901.3 2982.2 3074.1 3103.3 3105.4 109028.0 110832.0 111189.0 113438.0 116079.4 11342.6 11618.9 11637.8 11954.5 12004.7 25258.6 25451.2 25454.4 25515.4 25520.5 7712.1 7751.5 7892.2 7950.0 8153.7 4069.6 4094.8 4114.0 4114.4 4189.9 4127.4 4199.1 4233.0 4238.8 4446.1 854.7 864.8 870.6 874.4 874.7 531.9 545.8 548.8 565.9 573.3 9835.5 9948.3 9978.7 10558.9 10847.8 516.4 557.8 568.7 573.1 577.8 4036.3 4407.3 4449.6 4493.9 4750.8 102632.0 105139.0 106284.0 107258.0 108985.5 93862.0 94670.0 95395.6 97511.5 97868.5 79163.6 79851.0 81017.6 81453.0 81588.0 7900.7 8669.7 9255.4 9294.9 9317.8 33174.5 34382.3 35329.5 37816.4 39698.2 51517.0 65441.0 66028.3 67020.7 69377.7 12045.8 13692.1 13782.3 14063.0 14330.0 14055.7 14288.8 14334.9 14356.4 14362.3 13169.3 13307.5 13329.0 13338.5 13435.3 13042.3 13141.0 13271.8 13300.3 13387.3 12430.6 12499.5 12722.5 12770.2 13221.3 8733.7 9277.5 9541.4 9748.9 10349.6 8393.4 10335.2 10756.2 11136.9 11232.7 19:19:32 INFO - PID 2000 | -------- Summary: end -------- 19:19:32 INFO - PID 2000 | 19:19:32 INFO - TEST-INFO | 2000: exit 0 19:19:32 INFO - TEST-OK | dromaeo_css | took 1121559ms 19:19:32 INFO - TEST-START | kraken 19:19:32 INFO - operating with platform_type : mac_ 19:19:32 INFO - Initialising browser for kraken test... 19:19:32 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpaEZmr6/profile http://localhost:49301/getInfo.html) 19:19:35 INFO - PID 2006 | __metrics Screen width/height:1600/1200 19:19:35 INFO - PID 2006 | colorDepth:24 19:19:35 INFO - PID 2006 | Browser inner width/height: 1024/689 19:19:35 INFO - PID 2006 | __metrics 19:19:35 INFO - PID 2006 | 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:19:35 INFO - PID 2006 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:19:36 INFO - TEST-INFO | 2006: exit 0 19:19:36 INFO - Browser initialized. 19:19:36 INFO - Running cycle 1/1 for kraken test... 19:19:36 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpaEZmr6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:48 INFO - PID 2007 | RSS: Main: 234786816 19:19:48 INFO - PID 2007 | 19:19:51 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49301/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:52 INFO - PID 2007 | RSS: Main: 286875648 19:19:52 INFO - PID 2007 | 19:19:54 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49301/tests/kraken/driver.html?testName=audio-dft) 19:19:55 INFO - PID 2007 | RSS: Main: 287129600 19:19:55 INFO - PID 2007 | 19:19:59 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49301/tests/kraken/driver.html?testName=audio-fft) 19:19:59 INFO - PID 2007 | RSS: Main: 379895808 19:19:59 INFO - PID 2007 | 19:20:02 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49301/tests/kraken/driver.html?testName=audio-oscillator) 19:20:02 INFO - PID 2007 | RSS: Main: 283922432 19:20:02 INFO - PID 2007 | 19:20:04 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49301/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:20:05 INFO - PID 2007 | RSS: Main: 284348416 19:20:05 INFO - PID 2007 | 19:20:08 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49301/tests/kraken/driver.html?testName=imaging-darkroom) 19:20:09 INFO - PID 2007 | RSS: Main: 327073792 19:20:09 INFO - PID 2007 | 19:20:12 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49301/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:13 INFO - PID 2007 | RSS: Main: 336715776 19:20:13 INFO - PID 2007 | 19:20:16 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49301/tests/kraken/driver.html?testName=json-parse-financial) 19:20:17 INFO - PID 2007 | RSS: Main: 340328448 19:20:17 INFO - PID 2007 | 19:20:18 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49301/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:19 INFO - PID 2007 | RSS: Main: 305704960 19:20:19 INFO - PID 2007 | 19:20:21 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:21 INFO - PID 2007 | RSS: Main: 307011584 19:20:21 INFO - PID 2007 | 19:20:24 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:24 INFO - PID 2007 | RSS: Main: 308572160 19:20:24 INFO - PID 2007 | 19:20:28 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:28 INFO - PID 2007 | RSS: Main: 327565312 19:20:28 INFO - PID 2007 | 19:20:32 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:32 INFO - PID 2007 | RSS: Main: 321941504 19:20:32 INFO - PID 2007 | 19:20:34 INFO - PID 2007 | Cycle 1(1): loaded http://localhost:49301/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49301/tests/kraken/driver.html?testName=ai-astar) 19:20:35 INFO - PID 2007 | RSS: Main: 384626688 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | __start_tp_report 19:20:35 INFO - PID 2007 | _x_x_mozilla_page_load 19:20:35 INFO - PID 2007 | _x_x_mozilla_page_load_details 19:20:35 INFO - PID 2007 | |i|pagename|runs| 19:20:35 INFO - PID 2007 | |0;ai-astar;111;122;121;141;181;134;120;121;122;122 19:20:35 INFO - PID 2007 | |1;audio-beat-detection;160;120;121;161;120;123;124;158;157;120 19:20:35 INFO - PID 2007 | |2;audio-dft;215;214;220;302;235;216;214;211;212;219 19:20:35 INFO - PID 2007 | |3;audio-fft;87;62;64;103;66;61;63;61;84;68 19:20:35 INFO - PID 2007 | |4;audio-oscillator;98;76;97;77;74;75;94;73;76;90 19:20:35 INFO - PID 2007 | |5;imaging-gaussian-blur;92;90;90;92;91;91;92;91;96;112 19:20:35 INFO - PID 2007 | |6;imaging-darkroom;99;99;98;100;98;107;102;112;159;132 19:20:35 INFO - PID 2007 | |7;imaging-desaturate;103;104;101;102;101;101;101;101;104;99 19:20:35 INFO - PID 2007 | |8;json-parse-financial;51;52;50;51;50;53;51;51;51;62 19:20:35 INFO - PID 2007 | |9;json-stringify-tinderbox;58;62;72;75;58;63;72;93;97;94 19:20:35 INFO - PID 2007 | |10;stanford-crypto-aes;91;88;89;84;101;121;119;93;90;88 19:20:35 INFO - PID 2007 | |11;stanford-crypto-ccm;151;160;151;152;155;176;170;161;230;180 19:20:35 INFO - PID 2007 | |12;stanford-crypto-pbkdf2;205;229;203;197;202;201;201;201;199;198 19:20:35 INFO - PID 2007 | |13;stanford-crypto-sha256-iterative;75;97;109;72;75;72;71;76;74;76 19:20:35 INFO - PID 2007 | __end_tp_report 19:20:35 INFO - PID 2007 | __start_cc_report 19:20:35 INFO - PID 2007 | _x_x_mozilla_cycle_collect,2202 19:20:35 INFO - PID 2007 | __end_cc_report 19:20:35 INFO - PID 2007 | __startTimestamp1491013235059__endTimestamp 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | ------- Summary: start ------- 19:20:35 INFO - PID 2007 | Number of tests: 14 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#0] ai-astar Cycles:10 Average:129.50 Median:122.00 stddev:19.86 (16.3%) stddev-sans-first:19.91 19:20:35 INFO - PID 2007 | Values: 111.0 122.0 121.0 141.0 181.0 134.0 120.0 121.0 122.0 122.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:140.50 stddev:19.52 (13.9%) stddev-sans-first:18.75 19:20:35 INFO - PID 2007 | Values: 160.0 120.0 121.0 161.0 120.0 123.0 124.0 158.0 157.0 120.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#2] audio-dft Cycles:10 Average:225.80 Median:217.50 stddev:27.63 (12.7%) stddev-sans-first:29.03 19:20:35 INFO - PID 2007 | Values: 215.0 214.0 220.0 302.0 235.0 216.0 214.0 211.0 212.0 219.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#3] audio-fft Cycles:10 Average:71.90 Median:65.00 stddev:14.41 (22.2%) stddev-sans-first:14.21 19:20:35 INFO - PID 2007 | Values: 87.0 62.0 64.0 103.0 66.0 61.0 63.0 61.0 84.0 68.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#4] audio-oscillator Cycles:10 Average:83.00 Median:83.50 stddev:10.38 (12.4%) stddev-sans-first:9.49 19:20:35 INFO - PID 2007 | Values: 98.0 76.0 97.0 77.0 74.0 75.0 94.0 73.0 76.0 90.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:91.50 stddev:6.65 (7.3%) stddev-sans-first:7.03 19:20:35 INFO - PID 2007 | Values: 92.0 90.0 90.0 92.0 91.0 91.0 92.0 91.0 96.0 112.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#6] imaging-darkroom Cycles:10 Average:110.60 Median:128.50 stddev:19.97 (15.5%) stddev-sans-first:20.73 19:20:35 INFO - PID 2007 | Values: 99.0 99.0 98.0 100.0 98.0 107.0 102.0 112.0 159.0 132.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#7] imaging-desaturate Cycles:10 Average:101.70 Median:102.50 stddev:1.57 (1.5%) stddev-sans-first:1.59 19:20:35 INFO - PID 2007 | Values: 103.0 104.0 101.0 102.0 101.0 101.0 101.0 101.0 104.0 99.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:51.00 stddev:3.55 (7.0%) stddev-sans-first:3.74 19:20:35 INFO - PID 2007 | Values: 51.0 52.0 50.0 51.0 50.0 53.0 51.0 51.0 51.0 62.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:73.50 stddev:15.18 (20.7%) stddev-sans-first:14.90 19:20:35 INFO - PID 2007 | Values: 58.0 62.0 72.0 75.0 58.0 63.0 72.0 93.0 97.0 94.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#10] stanford-crypto-aes Cycles:10 Average:96.40 Median:88.50 stddev:13.20 (14.9%) stddev-sans-first:13.86 19:20:35 INFO - PID 2007 | Values: 91.0 88.0 89.0 84.0 101.0 121.0 119.0 93.0 90.0 88.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#11] stanford-crypto-ccm Cycles:10 Average:168.60 Median:165.50 stddev:23.96 (14.5%) stddev-sans-first:24.56 19:20:35 INFO - PID 2007 | Values: 151.0 160.0 151.0 152.0 155.0 176.0 170.0 161.0 230.0 180.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:203.60 Median:201.50 stddev:9.23 (4.6%) stddev-sans-first:9.77 19:20:35 INFO - PID 2007 | Values: 205.0 229.0 203.0 197.0 202.0 201.0 201.0 201.0 199.0 198.0 19:20:35 INFO - PID 2007 | 19:20:35 INFO - PID 2007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.70 Median:75.00 stddev:12.72 (17.0%) stddev-sans-first:13.38 19:20:35 INFO - PID 2007 | Values: 75.0 97.0 109.0 72.0 75.0 72.0 71.0 76.0 74.0 76.0 19:20:35 INFO - PID 2007 | -------- Summary: end -------- 19:20:35 INFO - PID 2007 | 19:20:35 INFO - TEST-INFO | 2007: exit 0 19:20:36 INFO - TEST-OK | kraken | took 63258ms 19:20:36 INFO - SUITE-END | took 1184s 19:20:36 INFO - Completed test suite (00:19:45) 19:20:36 INFO - javascript benchmark 19:20:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7697.527846599917, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3256.9511457328135, 3475.2528206435613, 3481.4255647818113, 3492.7205823534114, 3515.4023815951286, 5959.940400595992, 6103.816885493431, 6137.263528376601, 6139.938600613992, 6158.753649854, 6085.087236914465, 6102.847428814271, 6112.655464441472, 6118.284172697665, 6151.292601350846, 5177.922331165036, 5311.575073994071, 5352.063388906945, 5372.274742909696, 5406.189071639266, 5448.073827449323, 5479.835604931858, 5492.862678433051, 5493.862653433676, 5532.640378375413, 5248.0553500369915, 5317.46825317469, 5328.227407025959, 5341.359036915556, 5425.159100339473, 5385.21914322425, 5388.703621300827, 5411.972940135274, 5440.265564148829, 5469.507744303032, 5332.226827110047, 5359.624826262163, 5370.0, 5373.677579345252, 5413.323334583177, 5976.402359764033, 6034.547408944347, 6137.78517751881, 6142.385761423867, 6170.19787427636, 6379.425851673372, 6391.233052033739, 6392.4246817786625, 6396.0725694774, 6429.132067170919, 5590.804321848756, 6627.701753421107, 6694.531382803206, 6696.665166741692, 6698.162729658793, 6146.877062458726, 6171.907421388682, 6239.906401403937, 6241.531885108635, 6264.248290205204, 6835.179778426621, 6842.93157068423, 6850.177978642595, 6860.485463590251, 6865.210500792373, 6205.875882482415, 6307.432331090132, 6384.297727249998, 6481.4166724994975, 6558.344165583499, 6553.442957348583, 6603.867922641521, 6606.735730570819, 6622.768203112964, 6625.734970601218, 6510.576812507172, 6515.087887695727, 6520.315366886503, 6525.673716314261, 6531.934680653228, 6277.340879207617, 6377.936220637735, 6383.234011918599, 6539.411452969255, 6555.0, 5237.790488380499, 5239.580833533309, 5253.290805741252, 5255.343082114736, 5255.921161182585, 4609.654275929319, 4718.2214934536105, 4723.220668589713, 4734.171519984058, 4749.881252968704, 5064.594832413398, 6101.429060711456, 6134.938650613526, 6155.169052177988, 6156.661383623854, 6396.616203027833, 6501.252355979028, 6598.47212223021, 6629.370209830058, 6630.83422914431, 6254.405831446005, 6262.6868656566985, 6271.6550589718, 6277.843053923689, 6286.654234017173, 5842.036064049385, 5847.766089356378, 5848.298204215522, 5861.17943487912, 5915.0, 6533.18335208099, 6638.137042184485, 6639.103720997797, 6707.731690732316, 6815.454763618898, 5464.972675136599, 5686.2607860977805, 6525.543211975116, 6575.572587781779, 6611.239707433514, 6459.4832413405875, 6506.25178104524, 6617.272100069084, 6817.045613613999, 6832.59004459734, 6434.613923164625, 6529.902051469327, 6532.281449040506, 6540.476761859135, 6549.934500654933, 6300.621962682254, 6408.487321014401, 6621.238557565942, 6623.933760662332, 6625.602463852184, 6205.751769929333, 6215.751369945152, 6227.719752611234, 6244.1570387997035, 6334.208223972004, 5277.551408130198, 6397.456216221487, 6417.069524918954, 6432.35676432353, 6432.935670643234, 6284.811455656338, 6293.842653933505, 6302.464290535172, 6306.873862522815, 6316.62100273985, 6333.524985626189, 6434.903476447951, 6438.323975982642, 6454.5159113065765, 6460.644664543495, 6128.717018009172, 6226.097215903759, 6229.875402492015, 6230.221222347207, 6233.781817636361], "value": 5984.76804045498, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.4371018432006, 819.1644522586962, 1069.3370110531466, 1092.9398883061428, 1093.9015488606024, 37237.627623723754, 38005.80997095014, 38169.80915095421, 38217.80891095548, 38386.0, 40256.59743402565, 40702.0, 40708.0, 40806.59193408065, 40810.571629992955, 6184.412480814338, 6338.30278669346, 8617.612207450664, 8783.736487905373, 8796.0, 8501.744947651581, 8702.260307873807, 8720.651173953034, 8728.869066964, 8739.912600874006, 8745.344099192585, 8812.647494100229, 8815.77960550985, 8826.117388261187, 8827.16141966512, 8719.346049046315, 8786.956065219696, 8791.164839340252, 8802.471851688919, 8806.911930880673, 8569.914300856974, 8577.228049475578, 8622.870656940151, 8623.698170564063, 8631.136886311382, 38684.0, 38934.80532597319, 38948.415773763416, 38956.61043389587, 38999.805000975095, 2506.987465062681, 2956.4382767274365, 2978.3447641519047, 2979.06159559738, 3027.2129246395875, 22079.0, 27347.589786153225, 27487.876818477387, 27983.72016279852, 28298.434031319463, 2795.259256297083, 2830.8584570771377, 2863.8568071596337, 2864.298246929495, 2867.3978464522265, 349747.0, 352839.0, 354283.0, 355066.2246688776, 355243.2237838794, 40312.59687403088, 41409.96475088147, 41433.378499322534, 52355.0, 52850.0, 44734.88162795891, 44794.77602611966, 52145.95708085817, 52348.95302093937, 53220.0, 14118.50585229512, 14531.491397801026, 14880.776788348183, 14895.70208595822, 14897.851021489647, 12027.75944481123, 12147.0, 12170.57402990891, 12170.878291216974, 12173.513059477522, 13734.244616546186, 13755.17468951866, 13776.03567750248, 13847.961402894622, 13956.0, 5789.2763404574425, 5806.593538452352, 5850.2102216200265, 5852.0, 5862.501687356537, 825.3562221467265, 979.7893452907659, 995.785906030207, 1004.2468148888333, 1018.6383833739064, 22868.771312286997, 23573.7642623575, 24285.7571424287, 24448.266552003468, 24450.188228353967, 1076.6285631457135, 1084.2139448899484, 1101.735583459964, 1116.905063069632, 1120.5181771838024, 11789.823152652718, 12468.376581170905, 12505.0, 12565.18326308787, 12571.102958083024, 459855.0, 462163.0, 463302.0, 463432.0, 464520.0, 55821.720891395285, 56248.0, 56253.593660158, 56258.0, 56516.43483565112, 1451.0930668332292, 1475.2033901692967, 1518.916459594733, 1519.8252200996806, 1529.8699610533229, 21368.82471464022, 21992.89003554972, 23819.312018623405, 24062.25000372632, 24182.911768970087, 40379.394309085976, 40383.990400240225, 40430.39354409745, 40464.1907161861, 40494.392584111854, 432714.0, 433309.0, 434030.0, 434755.0, 435243.0, 26726.0, 30841.537376939814, 34753.478697819046, 34790.47814282838, 34802.30395392027, 42952.92617684583, 43342.69971900848, 43444.0, 43782.0, 43826.0, 23596.938137783498, 27861.0, 28392.148235552966, 30224.94212702545, 30728.539071914387, 28955.98654047098, 29115.563266550595, 29862.954796582017, 30050.549241760953, 30176.24559386033, 34274.65725342715, 35544.644553554135, 35644.28711425809, 35848.0, 38557.807210963765, 38326.0, 38787.6121238784, 39649.008774780865, 39649.04386951631, 39980.400293996194, 28713.0, 30355.544666829574, 30585.011974221605, 31404.685953140175, 31555.322286371433], "value": 18034.329952333075, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.721801693772, 422.48245898773985, 424.12418356094645, 435.7385568658805, 440.9184300904332, 19861.70898891571, 21246.681299780495, 21982.0, 22108.784016879104, 22143.0, 21424.714517128985, 22454.775452245474, 23002.0, 23201.535969280605, 23276.301710948657, 6097.939020609803, 6388.4889208863415, 6393.009083592027, 6394.040893865911, 6409.070684750708, 5951.6726580038085, 6296.905546416808, 6372.490200783926, 6375.521835862306, 6400.167978162833, 6082.270127584674, 6328.936710632904, 6339.302676705559, 6348.968255158741, 6354.586951848139, 6158.784442544512, 6263.31103578606, 6291.1506946562085, 6315.210598675166, 6329.0, 5365.382980957201, 5553.805616803433, 5597.580181486404, 5603.8879222415735, 5627.5779316551425, 27000.45999080027, 27065.86467067652, 27090.5936410954, 27202.0, 27505.449891002267, 2041.4794227472048, 2044.928427505045, 2055.486128467883, 2058.87646741196, 2106.1154315187505, 15550.844491555054, 16011.919940400223, 16269.105199214038, 16571.83428165715, 16927.238274277686, 1865.7947625761155, 1877.1458986161265, 1883.8210370014826, 1894.280173534062, 1917.836983856374, 137673.0, 142333.2883335587, 142653.0, 143044.2847785775, 145386.0, 11215.0, 11890.464929078213, 12073.577424790266, 12076.818847717292, 12328.780819452584, 13441.462341506425, 15941.804364672696, 16163.272652730655, 16212.35150593963, 16254.349826006828, 8597.441166324168, 8792.42849214799, 8811.55016716567, 8866.556672166365, 8943.865842012376, 8427.662893484314, 8448.07071222165, 8449.95775021121, 8574.528400937883, 8638.13618638131, 7483.2516748325825, 7615.581143037186, 7658.502197357154, 7678.385729141655, 7693.230676932262, 1901.3630433804553, 2059.124871929454, 2071.0576687607104, 2074.1703318672653, 2081.469225347527, 914.4239129348468, 953.1993125774383, 967.1150896929231, 985.408754747146, 993.7267251505893, 19019.0, 19146.617067658848, 20759.68860467094, 20878.060487278108, 21222.045007974677, 967.8741763570831, 972.3290929258789, 1001.8196724589498, 1002.2583288366557, 1004.4776716107583, 9908.405495670282, 10105.271576674257, 10385.376877387382, 10538.420386878643, 10568.894311056945, 672668.0, 673572.0, 679407.0, 680182.0, 700610.0, 151105.24447377914, 159968.0, 160592.0, 161968.1901590508, 162053.98433164583, 1143.822707480342, 1173.0791328807015, 1202.7895118354254, 1203.9699007524882, 1204.1209916760638, 17631.559211019827, 17883.821161788215, 17896.0, 18005.639887202444, 18024.549386265448, 61226.38773612385, 61753.073703895374, 62731.74083867452, 62949.37050629435, 64207.0, 86452.70320945066, 88634.11365886258, 89323.55012561967, 89822.0, 90322.64516032397, 8717.128287171232, 8726.781830454289, 8823.779405514657, 8843.778905527413, 8881.911180888108, 13512.6621834451, 13641.522546710818, 13696.315184240948, 14153.43386264538, 14177.503787367392, 11805.822912656145, 11842.881571184178, 12001.219920705125, 12136.696582585506, 12173.634790956285, 10956.452177391258, 10997.780044398907, 11289.379084150121, 11361.659150225507, 11377.2604780689, 11606.187566870238, 11617.535298587962, 12034.578789742318, 12069.75860482803, 12078.818817717916, 8357.122502137188, 8484.618192181244, 8548.187922147386, 8848.778780530538, 9031.96780724358, 11239.831402528805, 11425.828612570984, 11817.054635629302, 11862.406879656155, 12023.579174728842], "value": 10441.359866296396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1155.1394211312563, 1329.381837445588, 1379.3448112146732, 1393.3520912775562, 1404.6067101211659, 9268.907310926897, 9622.0, 10679.519421626026, 10992.0, 10999.61501347453, 10566.788664226711, 10665.946670266658, 10679.0, 10679.252452328341, 10714.78570428591, 2033.5627840014395, 2079.918442409946, 2085.967446114176, 2087.373787863635, 2088.0916801191456, 2065.535254567725, 2150.8171805396482, 2372.774586414288, 2458.1273647855023, 2469.987650061747, 2018.8384929205702, 2393.724721657006, 2429.149797570854, 2433.0267892842917, 2439.621858611918, 2378.7740164684415, 2385.5467461182407, 2415.625578035407, 2416.0698131219433, 2422.2733180046093, 2193.429708275844, 2347.976520234793, 2382.4996750682203, 2391.820613453998, 2423.164008417093, 10713.464326783629, 10771.246012779031, 10809.297395669335, 10894.891051089468, 10922.508487118099, 6085.452309292141, 6314.989601663712, 6328.272248691414, 6332.525060620425, 6339.936600633981, 3796.6583007529457, 4058.2086493133556, 4106.055607210328, 4111.938320925188, 4116.9794151029355, 1109.4896347679996, 1165.6561314412268, 1177.0877569883323, 1215.2708374975032, 1216.5255550335376, 15291.923540382339, 15418.537443876701, 15505.302261398265, 15514.922425387913, 15515.844841551552, 5370.140777475585, 5619.241402410622, 5626.718664066781, 5644.068728659725, 5732.570057245724, 12570.994320454342, 12595.622131336075, 12604.180728252633, 12606.306653133983, 12617.0, 6354.714037868307, 6356.745730170834, 6360.395762402564, 6360.618362898241, 6367.395097465734, 5437.537809286255, 5682.374938756733, 5760.481556659921, 5789.044807606782, 5790.305163380422, 3824.598417166213, 3924.6664033557468, 4215.831366745296, 4268.978655106766, 4300.65594752419, 1242.8570714367963, 1252.3300034481508, 1262.2489618676873, 1269.1243042300782, 1270.803025531044, 743.3792783026233, 746.9551826890404, 765.6286700950035, 767.5778321923032, 807.3258828877953, 5832.941670583325, 6283.560150789493, 6467.676616169173, 6516.706748196342, 6614.0740296358545, 870.1472556894279, 909.1408618855119, 914.9039350868063, 919.852823548229, 928.9674861379955, 3848.461215429842, 4007.73949693269, 4120.979395103005, 4124.711270211116, 4195.265828480004, 13486.86513134856, 14052.297385130703, 14067.085639433404, 14098.577042688736, 14105.435782568582, 13348.332583370986, 13899.16605003703, 13995.720085598232, 14025.298735063207, 14041.946853985992, 8288.461250018729, 9806.852897206547, 10071.446070466049, 10080.495975201211, 10106.39361638304, 5672.12082127271, 6296.5277604178955, 6521.836954076186, 6759.932400675931, 6786.626735529593, 12223.327716975651, 12593.118481706559, 12598.748025039631, 12611.558595449114, 12713.618591442271, 11227.0, 13002.219866808022, 13032.739345212853, 13032.934835325763, 13032.934835325763, 8838.823223535623, 9184.311176661644, 9190.49452280131, 9197.540122993958, 9202.769930751785, 8393.622286996977, 10020.0, 10087.445190514592, 10180.389176649425, 10240.590376384862, 8547.059823419544, 8550.144985501649, 8615.91384086151, 8867.290616750515, 8882.644694212158, 8384.622691978753, 8500.107488713844, 8545.82908341842, 8608.268297194558, 8666.523341216294, 7583.886241706489, 7654.196309387434, 7679.040119985002, 7727.768166955, 7748.457607967388, 5346.438623944586, 5806.158107074535, 5829.970850145722, 5868.530517558671, 5985.25184351956, 5830.47525722687, 5933.9109913352195, 5951.642901425928, 5957.49361304294, 6036.3661815510495], "value": 5129.2519600471405, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1721091048791, 387.3840593456405, 394.41232563480423, 395.55302508165767, 400.6334204203154, 5648.181013753004, 5914.8225553233415, 6149.969250153743, 6150.538709596775, 6156.5690401671845, 4581.793819278132, 5510.090835012228, 5548.44515548445, 5911.453128123124, 6010.248718910137, 3763.623637636228, 4210.915781684364, 4423.672898130564, 4605.240135377659, 4605.493395726484, 3760.417135344026, 3953.0, 4643.303504474339, 4651.8837029074375, 4670.76646167692, 3376.9906905391254, 4582.954170458286, 4583.404157459542, 4622.168009758242, 4654.720716757005, 4561.29299958507, 4566.794494247767, 4567.862964111082, 4574.199515084847, 4613.584777370036, 3158.4472717274616, 3712.6844218241213, 4060.9187816243807, 4061.0, 4084.244414783245, 5066.518680725325, 5556.583256255797, 5626.508975121596, 5789.623674461147, 5903.468687818074, 5412.755066334726, 5463.16983810424, 5471.863203419946, 5480.725963701799, 5515.641483303612, 6446.0, 6451.83870403239, 6455.451286640641, 6457.547971641987, 6475.248019591655, 4480.663950203715, 4565.223911934946, 4604.102200070987, 4619.353290539327, 4632.2125238709505, 6514.771982980573, 6669.833254168636, 6709.899351509731, 6725.764598239087, 6726.495512836557, 4600.631949444103, 4710.26990816424, 4725.298892398734, 4742.549457801503, 4757.666963312535, 4009.3785463253244, 4274.952636604052, 4809.975950120227, 4815.422149342101, 4822.517748225149, 4761.023990082025, 4864.683795553277, 5179.430262671103, 5383.380911195262, 5479.835604931858, 6159.260888693386, 6485.4163125318, 6506.609603423715, 6520.576162549419, 6527.89924785723, 1444.6966137111324, 1447.334226255934, 1507.5100592307545, 1647.983520164783, 1650.6946214950033, 876.3996662286227, 987.0425687083517, 991.613270824379, 1005.6480231918916, 1014.3102690170755, 6012.909806352908, 6154.5384096192065, 6156.953317935961, 6162.476189523851, 6163.705621819378, 6061.363556826558, 6616.636085015371, 6639.734410623521, 6645.734170633121, 6668.733250670016, 5342.439043900412, 6149.938500614937, 6168.475679567197, 6212.565120441525, 6245.375462453719, 2921.576371426131, 3474.4614584739406, 3477.200243943907, 3481.303739252109, 3496.9825150874085, 6569.704363303663, 6850.417714494324, 6875.828104297432, 6898.551594146365, 6929.930700692928, 5609.80365687199, 5950.7917222896995, 6842.93157068423, 6851.725930962805, 6852.211995620468, 6058.848528786815, 6394.776182833579, 6892.276310987374, 6911.0, 6916.827079323057, 6078.939210608014, 6631.867362652816, 6634.502412318999, 6670.7665231716655, 6693.19681638187, 6120.969395152996, 6331.27190373113, 6574.309697481887, 6586.901196481961, 6645.568038077703, 6110.388961103854, 6434.195725534309, 6752.459803215829, 6818.897716534355, 6898.965505172442, 4315.913681726411, 4385.627221686193, 4396.626286765661, 4404.55954404557, 4421.977890110529, 6076.817695469143, 6417.93582064192, 6596.60420374779, 6674.866502670016, 6695.163104611924, 6124.5712800103565, 6391.776287829904, 6440.9033864493, 6467.514936379885, 6498.610083395011, 6138.969305153446, 6412.294647588855, 6422.710978006095, 6428.19647544057, 6483.157189565326, 5645.576581756467, 5746.879358525048, 6351.460125889351, 6352.428281454691, 6370.58591191571, 5499.120140777456, 6186.391538200191, 6361.236651601837, 6449.6130232186215, 6456.515761317826, 6253.468455181179, 6260.342664020212, 6268.52986026059, 6287.96856015717, 6338.559654532945], "value": 4741.5084371215, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.955538086551, 728.0389885351336, 728.2062551818517, 734.247396418671, 745.3962290544656, 15866.682666346665, 16126.596835079128, 16172.433964811205, 16234.594135146612, 16235.918820405881, 12738.745225095492, 14380.568582942502, 14795.40818367264, 14969.550913472585, 15077.62305942352, 955.0926619711285, 971.6744890461704, 973.630020592174, 983.0562659846556, 1006.6023920551414, 972.0182615558301, 980.446047982891, 987.4322264697792, 989.4113002763344, 990.2919412619975, 1046.6232156423682, 1050.2543194332034, 1051.2378525568977, 1052.5368837711383, 1053.183782568508, 1033.689893032091, 1034.7257976636197, 1034.8602938603306, 1037.2013549566866, 1038.8857225705167, 771.5023809642805, 772.1660606544974, 772.4785769605494, 773.2190487607501, 773.3078894389546, 14089.64775880601, 16625.334986600523, 16635.916820415943, 16704.498865034067, 16898.493045208663, 14615.123092614476, 14753.70492590153, 14781.26093695311, 14864.62838429037, 14905.031172973722, 11697.649070527897, 11723.15613513825, 12030.458629361612, 12235.082368822374, 12261.448234829364, 2901.289184149876, 2982.164993801717, 3074.123874695701, 3103.2552187474844, 3105.378924215166, 109028.0, 110832.0, 111189.0, 113438.0, 116079.41960290144, 11342.60300889465, 11618.94190529042, 11637.76724465523, 11954.521819127138, 12004.699882502833, 25258.621120683205, 25451.23646290614, 25454.363640909127, 25515.36211594725, 25520.489590208093, 7712.113106992655, 7751.496152750054, 7892.210778922062, 7950.0, 8153.714619988272, 4069.5726948670554, 4094.8157332919495, 4114.0, 4114.382842573578, 4189.916201675949, 4127.380892866034, 4199.097194103282, 4232.957670423257, 4238.766867822238, 4446.088551846864, 854.7008547008621, 864.7967727584013, 870.5821205821114, 874.3660845886808, 874.7200895713438, 531.9388270348959, 545.7898708996985, 548.7695168029437, 565.8613639658311, 573.2576313673719, 9835.459049752333, 9948.321058544501, 9978.700638980843, 10558.855197804742, 10847.783044339227, 516.4293455731438, 557.8103444828778, 568.7260536398438, 573.057320707434, 577.8150991682621, 4036.253293140778, 4407.294832826732, 4449.638185985879, 4493.865184044484, 4750.8337208197545, 102632.0, 105139.0, 106284.0, 107258.0, 108985.45507272413, 93862.0, 94670.0, 95395.56906646406, 97511.51244243734, 97868.51065744768, 79163.60418197872, 79851.0, 81017.59491202506, 81453.0, 81588.0, 7900.723474678359, 8669.696560620348, 9255.444673319622, 9294.907050929403, 9317.767055823659, 33174.502382464765, 34382.280885956105, 35329.470057949664, 37816.43275350927, 39698.206035879695, 51517.0, 65441.0, 66028.33971660222, 67020.66489667521, 69377.65311173412, 12045.81931271014, 13692.05116172258, 13782.313196340774, 14063.0, 14330.0, 14055.718885622025, 14288.829418178297, 14334.856651433769, 14356.353964071433, 14362.281885905453, 13169.275689836768, 13307.467701292228, 13329.0, 13338.533151339656, 13435.328233588478, 13042.347882606022, 13141.0, 13271.800922986356, 13300.268485233406, 13387.330633468482, 12430.627081187216, 12499.500059992859, 12722.491100355883, 12770.23378597287, 13221.338933053117, 8733.737987860375, 9277.536123193948, 9541.427514349161, 9748.9025109748, 10349.586016559253, 8393.365140675412, 10335.22485813582, 10756.193285503463, 11136.888631113585, 11232.66302010941], "value": 7589.2603362245645, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1627.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 122.0, 121.0, 141.0, 181.0, 134.0, 120.0, 121.0, 122.0, 122.0], "value": 129.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 120.0, 121.0, 161.0, 120.0, 123.0, 124.0, 158.0, 157.0, 120.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [215.0, 214.0, 220.0, 302.0, 235.0, 216.0, 214.0, 211.0, 212.0, 219.0], "value": 225.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 62.0, 64.0, 103.0, 66.0, 61.0, 63.0, 61.0, 84.0, 68.0], "value": 71.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 76.0, 97.0, 77.0, 74.0, 75.0, 94.0, 73.0, 76.0, 90.0], "value": 83.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 90.0, 92.0, 91.0, 91.0, 92.0, 91.0, 96.0, 112.0], "value": 93.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 98.0, 100.0, 98.0, 107.0, 102.0, 112.0, 159.0, 132.0], "value": 110.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 104.0, 101.0, 102.0, 101.0, 101.0, 101.0, 101.0, 104.0, 99.0], "value": 101.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 50.0, 51.0, 50.0, 53.0, 51.0, 51.0, 51.0, 62.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 72.0, 75.0, 58.0, 63.0, 72.0, 93.0, 97.0, 94.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 89.0, 84.0, 101.0, 121.0, 119.0, 93.0, 90.0, 88.0], "value": 96.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 160.0, 151.0, 152.0, 155.0, 176.0, 170.0, 161.0, 230.0, 180.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 229.0, 203.0, 197.0, 202.0, 201.0, 201.0, 201.0, 199.0, 198.0], "value": 203.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 97.0, 109.0, 72.0, 75.0, 72.0, 71.0, 76.0, 74.0, 76.0], "value": 79.7, "unit": "score"}]}]} 19:20:36 INFO - Return code: 0 19:20:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:20:36 ERROR - # TBPL SUCCESS # 19:20:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:20:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:20:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:20:36 INFO - 2017-03-31 19:20:36.393 screenresolution[2011:21827] starting screenresolution argv=screenresolution get 19:20:36 INFO - 2017-03-31 19:20:36.396 screenresolution[2011:21827] Display 0: 1600x1200x32@60 19:20:36 INFO - 2017-03-31 19:20:36.402 screenresolution[2012:21830] starting screenresolution argv=screenresolution list 19:20:36 INFO - Available Modes on Display 0 19:20:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:20:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:20:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:20:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:20:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:20:36 INFO - Intel Iris: 19:20:36 INFO - Chipset Model: Intel Iris 19:20:36 INFO - Type: GPU 19:20:36 INFO - Bus: Built-In 19:20:36 INFO - VRAM (Dynamic, Max): 1536 MB 19:20:36 INFO - Vendor: Intel (0x8086) 19:20:36 INFO - Device ID: 0x0a2e 19:20:36 INFO - Revision ID: 0x0009 19:20:36 INFO - Displays: 19:20:36 INFO - Display: 19:20:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:20:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:20:36 INFO - Display Serial Number: 1600x1200 60 19:20:36 INFO - Main Display: Yes 19:20:36 INFO - Mirror: Off 19:20:36 INFO - Online: Yes 19:20:36 INFO - Rotation: Supported 19:20:36 INFO - Return code: 0 19:20:36 INFO - Running post-action listener: _resource_record_post_action 19:20:36 INFO - [mozharness: 2017-04-01 02:20:36.638412Z] Finished run-tests step (success) 19:20:36 INFO - Running post-run listener: _resource_record_post_run 19:20:36 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 31984640; Write bytes: 514678784; Read time: 295; Write time: 1579 19:20:36 INFO - TinderboxPrint: CPU usage
53.3% 19:20:36 INFO - TinderboxPrint: I/O read bytes / time
31,984,640 / 295 19:20:36 INFO - TinderboxPrint: I/O write bytes / time
514,678,784 / 1,579 19:20:36 INFO - TinderboxPrint: CPU idle
2,255.5 (46.7%) 19:20:36 INFO - TinderboxPrint: CPU system
961.9 (19.9%) 19:20:36 INFO - TinderboxPrint: CPU user
1,608.2 (33.3%) 19:20:36 INFO - TinderboxPrint: Swap in / out
238,292,992 / 0 19:20:36 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207063552; Write bytes: 202727424; Read time: 15663; Write time: 355 19:20:36 INFO - run-tests - Wall time: 1186s; CPU: 53.0%; Read bytes: 31808512; Write bytes: 300904448; Read time: 291; Write time: 1191 19:20:37 INFO - Running post-run listener: _upload_blobber_files 19:20:37 INFO - Blob upload gear active. 19:20:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:37 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 19:20:37 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'] 19:20:37 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 19:20:37 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:20:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:20:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:38 INFO - (blobuploader) - INFO - Done attempting. 19:20:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:20:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:20:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:39 INFO - (blobuploader) - INFO - Done attempting. 19:20:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:20:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:20:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:40 INFO - (blobuploader) - INFO - Done attempting. 19:20:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:20:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:20:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:42 INFO - (blobuploader) - INFO - Done attempting. 19:20:42 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:42 INFO - Return code: 0 19:20:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:20:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc51d17645e6e8f66d4f5a1537f926722a7820406a42e6f798e0f5a9675cc390ad95a87eb9ef39d248143d5ce39ea519b6f5f6133f430fa8e8336d20de4718e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36382da96b5b8373a2cd64d6ceaaaf94c5aa95c0139cce1b8726f7cffee0d281770ed9c31e58afada396b851afc352875b7dda6fdee6d003399c54bc8ae7a969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f55aebae9444fc6a8307b0b0d55f11b7279e04cda2b9939bc6a1460603ef4a6a32d31ad27365f2fe1f99515ec89141ba161c9890b077a0be6f20686db5055de2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc867d08afbff0c06f3aeb191b2e50843b2aa2a2c0f8f936a690c5bcd115f3121f3eb892748fa0233d0738b4a80ae5cd62b3e762c70843a209dea4db0058d7d2"} 19:20:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:20:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:20:42 INFO - Contents: 19:20:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc51d17645e6e8f66d4f5a1537f926722a7820406a42e6f798e0f5a9675cc390ad95a87eb9ef39d248143d5ce39ea519b6f5f6133f430fa8e8336d20de4718e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36382da96b5b8373a2cd64d6ceaaaf94c5aa95c0139cce1b8726f7cffee0d281770ed9c31e58afada396b851afc352875b7dda6fdee6d003399c54bc8ae7a969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f55aebae9444fc6a8307b0b0d55f11b7279e04cda2b9939bc6a1460603ef4a6a32d31ad27365f2fe1f99515ec89141ba161c9890b077a0be6f20686db5055de2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc867d08afbff0c06f3aeb191b2e50843b2aa2a2c0f8f936a690c5bcd115f3121f3eb892748fa0233d0738b4a80ae5cd62b3e762c70843a209dea4db0058d7d2"} 19:20:42 INFO - Running post-run listener: copy_logs_to_upload_dir 19:20:42 INFO - Copying logs to upload dir... 19:20:42 INFO - mkdir: /builds/slave/test/build/upload/logs 19:20:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1293.151047 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2017-03-31 19:20:42.493600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 19:20:42.498855) ========= 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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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/dc51d17645e6e8f66d4f5a1537f926722a7820406a42e6f798e0f5a9675cc390ad95a87eb9ef39d248143d5ce39ea519b6f5f6133f430fa8e8336d20de4718e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36382da96b5b8373a2cd64d6ceaaaf94c5aa95c0139cce1b8726f7cffee0d281770ed9c31e58afada396b851afc352875b7dda6fdee6d003399c54bc8ae7a969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f55aebae9444fc6a8307b0b0d55f11b7279e04cda2b9939bc6a1460603ef4a6a32d31ad27365f2fe1f99515ec89141ba161c9890b077a0be6f20686db5055de2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc867d08afbff0c06f3aeb191b2e50843b2aa2a2c0f8f936a690c5bcd115f3121f3eb892748fa0233d0738b4a80ae5cd62b3e762c70843a209dea4db0058d7d2"} build_url:https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011018 build_url: 'https://queue.taskcluster.net/v1/task/A6skzkulSZynfaCNbbldAQ/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/dc51d17645e6e8f66d4f5a1537f926722a7820406a42e6f798e0f5a9675cc390ad95a87eb9ef39d248143d5ce39ea519b6f5f6133f430fa8e8336d20de4718e5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/36382da96b5b8373a2cd64d6ceaaaf94c5aa95c0139cce1b8726f7cffee0d281770ed9c31e58afada396b851afc352875b7dda6fdee6d003399c54bc8ae7a969", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f55aebae9444fc6a8307b0b0d55f11b7279e04cda2b9939bc6a1460603ef4a6a32d31ad27365f2fe1f99515ec89141ba161c9890b077a0be6f20686db5055de2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fc867d08afbff0c06f3aeb191b2e50843b2aa2a2c0f8f936a690c5bcd115f3121f3eb892748fa0233d0738b4a80ae5cd62b3e762c70843a209dea4db0058d7d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 19:20:42.534290) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 19:20:42.534676) ========= 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.OgtL1Aak7J/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.YIaIioRgyZ/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.005268 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 19:20:42.583546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 19:20:42.583861) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 19:20:42.584182) ========= ========= Total master_lag: 0.20 =========