builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0148 starttime: 1490929739.84 results: success (0) buildid: 20170330191006 builduid: 5be1e18753b44f98bc6e4a47ddb2b0d5 revision: 14b6ab023dec51a423a034aa8f307c56776d59c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 20:08:59.844543) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-30 20:08:59.844974) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 20:08:59.845266) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-30 20:08:59.870024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:08:59.870425) ========= 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.FBst7QKjWE/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.3CNru181Ae/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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-30 20:08:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 5.61M=0.002s 2017-03-30 20:08:59 (5.61 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:08:59.976027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:08:59.976352) ========= 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.FBst7QKjWE/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.3CNru181Ae/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.020851 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:09:00.024944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-30 20:09:00.025304) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 14b6ab023dec51a423a034aa8f307c56776d59c1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 14b6ab023dec51a423a034aa8f307c56776d59c1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FBst7QKjWE/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.3CNru181Ae/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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-30 20:09:00,107 truncating revision to first 12 chars 2017-03-30 20:09:00,107 Setting DEBUG logging. 2017-03-30 20:09:00,107 attempt 1/10 2017-03-30 20:09:00,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/14b6ab023dec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-30 20:09:02,331 unpacking tar archive at: mozilla-beta-14b6ab023dec/testing/mozharness/ program finished with exit code 0 elapsedTime=2.477773 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-30 20:09:02.526454) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 20:09:02.526820) ========= script_repo_revision: 14b6ab023dec51a423a034aa8f307c56776d59c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-30 20:09:02.527215) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 20:09:02.527481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-30 20:09:02.547758) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-30 20:09:02.548377) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FBst7QKjWE/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.3CNru181Ae/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 20:09:02 INFO - MultiFileLogger online at 20170330 20:09:02 in /builds/slave/test 20:09:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:09:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:09:02 INFO - {'append_to_log': False, 20:09:02 INFO - 'base_work_dir': '/builds/slave/test', 20:09:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:09:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:09:02 INFO - 'branch': 'Mozilla-Beta', 20:09:02 INFO - 'buildbot_json_path': 'buildprops.json', 20:09:02 INFO - 'config_files': ('talos/mac_config.py',), 20:09:02 INFO - 'default_actions': ('clobber', 20:09:02 INFO - 'read-buildbot-config', 20:09:02 INFO - 'download-and-extract', 20:09:02 INFO - 'populate-webroot', 20:09:02 INFO - 'create-virtualenv', 20:09:02 INFO - 'install', 20:09:02 INFO - 'run-tests'), 20:09:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:09:02 INFO - 'download_minidump_stackwalk': True, 20:09:02 INFO - 'download_symbols': 'ondemand', 20:09:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:09:02 INFO - 'tooltool.py': '/tools/tooltool.py', 20:09:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:09:02 INFO - '/tools/misc-python/virtualenv.py')}, 20:09:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:09:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:09:02 INFO - 'installer_path': 'installer.exe', 20:09:02 INFO - 'log_level': 'info', 20:09:02 INFO - 'log_name': 'talos', 20:09:02 INFO - 'log_to_console': True, 20:09:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:09:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:09:02 INFO - 'opt_config_files': (), 20:09:02 INFO - 'pip_index': False, 20:09:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:09:02 INFO - 'cmd': ('bash', 20:09:02 INFO - '-c', 20:09:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:09:02 INFO - 'enabled': True, 20:09:02 INFO - 'halt_on_failure': False, 20:09:02 INFO - 'name': 'check_screen_resolution'},), 20:09:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:09:02 INFO - 'cmd': ('bash', 20:09:02 INFO - '-c', 20:09:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:09:02 INFO - 'enabled': True, 20:09:02 INFO - 'halt_on_failure': False, 20:09:02 INFO - 'name': 'check_screen_resolution'},), 20:09:02 INFO - 'run_cmd_checks_enabled': True, 20:09:02 INFO - 'sps_profile': False, 20:09:02 INFO - 'sps_profile_interval': 0, 20:09:02 INFO - 'suite': 'dromaeojs', 20:09:02 INFO - 'system_bits': '32', 20:09:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:09:02 INFO - 'title': 't-yosemite-r7-0148', 20:09:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:09:02 INFO - 'use_talos_json': True, 20:09:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:09:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:09:02 INFO - 'work_dir': 'build'} 20:09:02 INFO - [mozharness: 2017-03-31 03:09:02.765559Z] Running clobber step. 20:09:02 INFO - Running pre-action listener: _resource_record_pre_action 20:09:02 INFO - Running main action method: clobber 20:09:02 INFO - rmtree: /builds/slave/test/build 20:09:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:09:04 INFO - Running post-action listener: _resource_record_post_action 20:09:04 INFO - [mozharness: 2017-03-31 03:09:04.739265Z] Finished clobber step (success) 20:09:04 INFO - [mozharness: 2017-03-31 03:09:04.739480Z] Running read-buildbot-config step. 20:09:04 INFO - Running pre-action listener: _resource_record_pre_action 20:09:04 INFO - Running main action method: read_buildbot_config 20:09:04 INFO - Using buildbot properties: 20:09:04 INFO - { 20:09:04 INFO - "project": "", 20:09:04 INFO - "product": "firefox", 20:09:04 INFO - "script_repo_revision": "production", 20:09:04 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 20:09:04 INFO - "repository": "", 20:09:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 20:09:04 INFO - "buildid": "20170330191006", 20:09:04 INFO - "pgo_build": "False", 20:09:04 INFO - "basedir": "/builds/slave/test", 20:09:04 INFO - "buildnumber": 5, 20:09:04 INFO - "slavename": "t-yosemite-r7-0148", 20:09:04 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:09:04 INFO - "platform": "yosemite_r7", 20:09:04 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:09:04 INFO - "branch": "mozilla-beta", 20:09:04 INFO - "repo_path": "releases/mozilla-beta", 20:09:04 INFO - "revision": "14b6ab023dec51a423a034aa8f307c56776d59c1", 20:09:04 INFO - "stage_platform": "macosx64", 20:09:04 INFO - "builduid": "5be1e18753b44f98bc6e4a47ddb2b0d5", 20:09:04 INFO - "slavebuilddir": "test" 20:09:04 INFO - } 20:09:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 20:09:04 INFO - Running post-action listener: _resource_record_post_action 20:09:04 INFO - [mozharness: 2017-03-31 03:09:04.745331Z] Finished read-buildbot-config step (success) 20:09:04 INFO - [mozharness: 2017-03-31 03:09:04.745433Z] Running download-and-extract step. 20:09:04 INFO - Running pre-action listener: _resource_record_pre_action 20:09:04 INFO - Running main action method: download_and_extract 20:09:04 INFO - mkdir: /builds/slave/test/build/tests 20:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:04 INFO - trying https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 20:09:04 INFO - Downloading https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 20:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 20:09:06 INFO - Downloaded 1165 bytes. 20:09:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 20:09:06 INFO - Using the following test package requirements: 20:09:06 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 20:09:06 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:09:06 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 20:09:06 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:09:06 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 20:09:06 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:09:06 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:09:06 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 20:09:06 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 20:09:06 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:09:06 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 20:09:06 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:09:06 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 20:09:06 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:09:06 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 20:09:06 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 20:09:06 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 20:09:06 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 20:09:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 20:09:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 20:09:06 INFO - Fetch https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 20:09:07 INFO - Expected file size: 16108765 20:09:07 INFO - Obtained file size: 16108765 20:09:13 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 20:09:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 20:09:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 20:09:13 INFO - Fetch https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 20:09:14 INFO - Expected file size: 16108765 20:09:14 INFO - Obtained file size: 16108765 20:09:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 20:09:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 20:09:21 INFO - Fetch https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 20:09:22 INFO - Expected file size: 14403663 20:09:22 INFO - Obtained file size: 14403663 20:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:22 INFO - trying https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 20:09:22 INFO - Downloading https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 20:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 20:09:24 INFO - Downloaded 58692397 bytes. 20:09:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 20:09:24 INFO - mkdir: /builds/slave/test/properties 20:09:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:09:24 INFO - Writing to file /builds/slave/test/properties/build_url 20:09:24 INFO - Contents: 20:09:24 INFO - build_url:https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg 20:09:25 INFO - Running post-action listener: _resource_record_post_action 20:09:25 INFO - Running post-action listener: set_extra_try_arguments 20:09:25 INFO - [mozharness: 2017-03-31 03:09:25.230346Z] Finished download-and-extract step (success) 20:09:25 INFO - [mozharness: 2017-03-31 03:09:25.230490Z] Running populate-webroot step. 20:09:25 INFO - Running pre-action listener: _resource_record_pre_action 20:09:25 INFO - Running main action method: populate_webroot 20:09:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:09:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:09:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:09:25 INFO - '--tppagecycles', 20:09:25 INFO - '7'], 20:09:25 INFO - 'tests': ['tsvgm']}}, 20:09:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:09:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:09:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:09:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:09:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:09:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:09:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:09:25 INFO - 'talos_options': ['--disable-e10s'], 20:09:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:09:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:09:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:09:25 INFO - 'talos_options': ['--disable-e10s'], 20:09:25 INFO - 'tests': ['damp', 'tps']}, 20:09:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:09:25 INFO - 'tests': ['damp', 'tps']}, 20:09:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:09:25 INFO - 'tests': ['dromaeo_dom']}, 20:09:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:09:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:09:25 INFO - 'tests': ['basic_compositor_video']}, 20:09:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:09:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:09:25 INFO - 'tests': ['a11yr', 20:09:25 INFO - 'ts_paint', 20:09:25 INFO - 'tpaint', 20:09:25 INFO - 'sessionrestore', 20:09:25 INFO - 'sessionrestore_no_auto_restore', 20:09:25 INFO - 'tabpaint']}, 20:09:25 INFO - 'other-e10s': {'tests': ['a11yr', 20:09:25 INFO - 'ts_paint', 20:09:25 INFO - 'tpaint', 20:09:25 INFO - 'sessionrestore', 20:09:25 INFO - 'sessionrestore_no_auto_restore', 20:09:25 INFO - 'tabpaint']}, 20:09:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:09:25 INFO - 'ts_paint', 20:09:25 INFO - 'tpaint', 20:09:25 INFO - 'sessionrestore', 20:09:25 INFO - 'sessionrestore_no_auto_restore', 20:09:25 INFO - 'tabpaint']}, 20:09:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:09:25 INFO - 'ts_paint', 20:09:25 INFO - 'tpaint', 20:09:25 INFO - 'sessionrestore', 20:09:25 INFO - 'sessionrestore_no_auto_restore', 20:09:25 INFO - 'tabpaint']}, 20:09:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:09:25 INFO - 'tests': ['a11yr', 20:09:25 INFO - 'ts_paint', 20:09:25 INFO - 'tpaint', 20:09:25 INFO - 'sessionrestore', 20:09:25 INFO - 'sessionrestore_no_auto_restore', 20:09:25 INFO - 'tabpaint']}, 20:09:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:09:25 INFO - 'tests': ['a11yr', 20:09:25 INFO - 'ts_paint', 20:09:25 INFO - 'tpaint', 20:09:25 INFO - 'sessionrestore', 20:09:25 INFO - 'sessionrestore_no_auto_restore', 20:09:25 INFO - 'tabpaint']}, 20:09:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:09:25 INFO - 'tests': ['tsvgx', 20:09:25 INFO - 'tsvgr_opacity', 20:09:25 INFO - 'tart', 20:09:25 INFO - 'tscrollx', 20:09:25 INFO - 'cart', 20:09:25 INFO - 'tsvg_static']}, 20:09:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:09:25 INFO - 'tsvgr_opacity', 20:09:25 INFO - 'tart', 20:09:25 INFO - 'tscrollx', 20:09:25 INFO - 'cart', 20:09:25 INFO - 'tsvg_static']}, 20:09:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:09:25 INFO - 'talos_options': ['--disable-e10s'], 20:09:25 INFO - 'tests': ['tp5o']}, 20:09:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:09:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:09:25 INFO - 'talos_options': ['--disable-e10s', 20:09:25 INFO - '--xperf_path', 20:09:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:25 INFO - 'tests': ['tp5n']}, 20:09:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:09:25 INFO - 'talos_options': ['--xperf_path', 20:09:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:09:25 INFO - 'tests': ['tp5n']}}, 20:09:25 INFO - 'talos.zip': {'path': '', 20:09:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:09:25 INFO - Running post-action listener: _resource_record_post_action 20:09:25 INFO - [mozharness: 2017-03-31 03:09:25.248662Z] Finished populate-webroot step (success) 20:09:25 INFO - [mozharness: 2017-03-31 03:09:25.248756Z] Running create-virtualenv step. 20:09:25 INFO - Running pre-action listener: _resource_record_pre_action 20:09:25 INFO - Running main action method: create_virtualenv 20:09:25 INFO - Creating virtualenv /builds/slave/test/build/venv 20:09:25 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 20:09:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:09:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:09:25 INFO - Using real prefix '/tools/python27' 20:09:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:09:26 INFO - Installing distribute.............................................................................................................................................................................................done. 20:09:28 INFO - Installing pip.................done. 20:09:28 INFO - Return code: 0 20:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:09:29 INFO - Reading from file tmpfile_stdout 20:09:29 INFO - Output received: 20:09:29 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) 20:09:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1043edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a7247ab00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041cbd30>, '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 0x1040f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c0be8>, '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.FBst7QKjWE/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.3CNru181Ae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 20:09: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', 'pip>=1.5'] in /builds/slave/test/build 20:09: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 pip>=1.5 20:09:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FBst7QKjWE/Render', 20:09:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:29 INFO - 'HOME': '/Users/cltbld', 20:09:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:29 INFO - 'LOGNAME': 'cltbld', 20:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:29 INFO - 'MOZ_NO_REMOTE': '1', 20:09:29 INFO - 'NO_EM_RESTART': '1', 20:09:29 INFO - 'PAGER': '/bin/cat', 20:09:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:29 INFO - 'PWD': '/builds/slave/test', 20:09:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:29 INFO - 'SHELL': '/bin/bash', 20:09:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CNru181Ae/Listeners', 20:09:29 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 20:09:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:29 INFO - 'USER': 'cltbld', 20:09:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:29 INFO - 'XPC_FLAGS': '0x0', 20:09:29 INFO - 'XPC_SERVICE_NAME': '0', 20:09:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:29 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 20:09:29 INFO - Cleaning up... 20:09:29 INFO - Return code: 0 20:09:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:09: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')]} 20:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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')]} 20:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09: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', '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 0x1043edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a7247ab00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041cbd30>, '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 0x1040f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c0be8>, '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.FBst7QKjWE/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.3CNru181Ae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 20:09: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:09: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 psutil>=3.1.1 20:09:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FBst7QKjWE/Render', 20:09:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:29 INFO - 'HOME': '/Users/cltbld', 20:09:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:29 INFO - 'LOGNAME': 'cltbld', 20:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:29 INFO - 'MOZ_NO_REMOTE': '1', 20:09:29 INFO - 'NO_EM_RESTART': '1', 20:09:29 INFO - 'PAGER': '/bin/cat', 20:09:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:29 INFO - 'PWD': '/builds/slave/test', 20:09:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:29 INFO - 'SHELL': '/bin/bash', 20:09:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CNru181Ae/Listeners', 20:09:29 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 20:09:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:29 INFO - 'USER': 'cltbld', 20:09:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:29 INFO - 'XPC_FLAGS': '0x0', 20:09:29 INFO - 'XPC_SERVICE_NAME': '0', 20:09:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:30 INFO - Downloading/unpacking psutil>=3.1.1 20:09:30 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 20:09:30 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 20:09:30 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 20:09:30 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 20:09:30 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 20:09:30 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 20:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:09:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:33 INFO - Installing collected packages: psutil 20:09:33 INFO - Running setup.py install for psutil 20:09:33 INFO - building 'psutil._psutil_osx' extension 20:09:33 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 20:09:33 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 20:09:33 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 20:09:34 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 20:09:34 INFO - building 'psutil._psutil_posix' extension 20:09:34 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 20:09:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:09:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:09:34 INFO - ^ 20:09:34 INFO - 1 warning generated. 20:09:34 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 20:09:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:09:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:09:34 INFO - Successfully installed psutil 20:09:34 INFO - Cleaning up... 20:09:34 INFO - Return code: 0 20:09:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:09:34 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')]} 20:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:34 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')]} 20:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:34 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 0x1043edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a7247ab00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041cbd30>, '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 0x1040f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c0be8>, '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.FBst7QKjWE/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.3CNru181Ae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 20:09:34 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 20:09:34 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 20:09:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FBst7QKjWE/Render', 20:09:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:34 INFO - 'HOME': '/Users/cltbld', 20:09:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:34 INFO - 'LOGNAME': 'cltbld', 20:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:34 INFO - 'MOZ_NO_REMOTE': '1', 20:09:34 INFO - 'NO_EM_RESTART': '1', 20:09:34 INFO - 'PAGER': '/bin/cat', 20:09:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:34 INFO - 'PWD': '/builds/slave/test', 20:09:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:34 INFO - 'SHELL': '/bin/bash', 20:09:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CNru181Ae/Listeners', 20:09:34 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 20:09:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:34 INFO - 'USER': 'cltbld', 20:09:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:34 INFO - 'XPC_FLAGS': '0x0', 20:09:34 INFO - 'XPC_SERVICE_NAME': '0', 20:09:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:09:37 INFO - Installing collected packages: mozsystemmonitor 20:09:37 INFO - Running setup.py install for mozsystemmonitor 20:09:37 INFO - Successfully installed mozsystemmonitor 20:09:37 INFO - Cleaning up... 20:09:37 INFO - Return code: 0 20:09:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:09:37 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')]} 20:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:37 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')]} 20:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:37 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 0x1043edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a7247ab00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041cbd30>, '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 0x1040f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c0be8>, '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.FBst7QKjWE/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.3CNru181Ae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 20:09:37 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 20:09:37 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 20:09:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FBst7QKjWE/Render', 20:09:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:37 INFO - 'HOME': '/Users/cltbld', 20:09:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:37 INFO - 'LOGNAME': 'cltbld', 20:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:37 INFO - 'MOZ_NO_REMOTE': '1', 20:09:37 INFO - 'NO_EM_RESTART': '1', 20:09:37 INFO - 'PAGER': '/bin/cat', 20:09:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:37 INFO - 'PWD': '/builds/slave/test', 20:09:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:37 INFO - 'SHELL': '/bin/bash', 20:09:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CNru181Ae/Listeners', 20:09:37 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 20:09:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:37 INFO - 'USER': 'cltbld', 20:09:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:37 INFO - 'XPC_FLAGS': '0x0', 20:09:37 INFO - 'XPC_SERVICE_NAME': '0', 20:09:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:37 INFO - Downloading/unpacking jsonschema==2.5.1 20:09:37 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 20:09:37 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 20:09:37 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 20:09:37 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 20:09:37 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 20:09:37 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 20:09:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:09:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:40 INFO - Downloading functools32-3.2.3-2.tar.gz 20:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:09:41 INFO - warning: no files found matching '*.txt' 20:09:41 INFO - no previously-included directories found matching 'build' 20:09:41 INFO - no previously-included directories found matching 'dist' 20:09:41 INFO - no previously-included directories found matching '.git*' 20:09:41 INFO - Installing collected packages: jsonschema, functools32 20:09:41 INFO - Running setup.py install for functools32 20:09:41 INFO - warning: no files found matching '*.txt' 20:09:41 INFO - no previously-included directories found matching 'build' 20:09:41 INFO - no previously-included directories found matching 'dist' 20:09:41 INFO - no previously-included directories found matching '.git*' 20:09:41 INFO - Successfully installed jsonschema functools32 20:09:41 INFO - Cleaning up... 20:09:41 INFO - Return code: 0 20:09:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:09:41 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')]} 20:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:41 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')]} 20:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:41 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 0x1043edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a7247ab00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041cbd30>, '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 0x1040f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c0be8>, '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.FBst7QKjWE/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.3CNru181Ae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 20:09:41 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 20:09:41 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 20:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FBst7QKjWE/Render', 20:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:41 INFO - 'HOME': '/Users/cltbld', 20:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:41 INFO - 'LOGNAME': 'cltbld', 20:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:41 INFO - 'MOZ_NO_REMOTE': '1', 20:09:41 INFO - 'NO_EM_RESTART': '1', 20:09:41 INFO - 'PAGER': '/bin/cat', 20:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:41 INFO - 'PWD': '/builds/slave/test', 20:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:41 INFO - 'SHELL': '/bin/bash', 20:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CNru181Ae/Listeners', 20:09:41 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 20:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:41 INFO - 'USER': 'cltbld', 20:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:41 INFO - 'XPC_FLAGS': '0x0', 20:09:41 INFO - 'XPC_SERVICE_NAME': '0', 20:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:09:41 INFO - Cleaning up... 20:09:41 INFO - Return code: 0 20:09:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:09:41 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')]} 20:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:41 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')]} 20:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:41 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 0x1043edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a7247ab00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041cbd30>, '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 0x1040f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c0be8>, '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.FBst7QKjWE/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.3CNru181Ae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 20:09:41 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 20:09:41 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 20:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FBst7QKjWE/Render', 20:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:41 INFO - 'HOME': '/Users/cltbld', 20:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:41 INFO - 'LOGNAME': 'cltbld', 20:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:41 INFO - 'MOZ_NO_REMOTE': '1', 20:09:41 INFO - 'NO_EM_RESTART': '1', 20:09:41 INFO - 'PAGER': '/bin/cat', 20:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:41 INFO - 'PWD': '/builds/slave/test', 20:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:41 INFO - 'SHELL': '/bin/bash', 20:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CNru181Ae/Listeners', 20:09:41 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 20:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:41 INFO - 'USER': 'cltbld', 20:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:41 INFO - 'XPC_FLAGS': '0x0', 20:09:41 INFO - 'XPC_SERVICE_NAME': '0', 20:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:41 INFO - Downloading/unpacking blobuploader==1.2.4 20:09:41 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 20:09:41 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 20:09:41 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 20:09:41 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 20:09:41 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 20:09:41 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 20:09:44 INFO - Downloading blobuploader-1.2.4.tar.gz 20:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:09:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:09:44 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 20:09:44 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 20:09:44 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 20:09:44 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 20:09:44 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 20:09:44 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 20:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:09:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:09:45 INFO - Downloading docopt-0.6.1.tar.gz 20:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:09:45 INFO - Installing collected packages: blobuploader, requests, docopt 20:09:45 INFO - Running setup.py install for blobuploader 20:09:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:09:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:09:45 INFO - Running setup.py install for requests 20:09:46 INFO - Running setup.py install for docopt 20:09:46 INFO - Successfully installed blobuploader requests docopt 20:09:46 INFO - Cleaning up... 20:09:46 INFO - Return code: 0 20:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:46 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 0x1043edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a7247ab00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041cbd30>, '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 0x1040f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c0be8>, '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.FBst7QKjWE/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.3CNru181Ae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 20:09:46 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 20:09:46 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 20:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FBst7QKjWE/Render', 20:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:46 INFO - 'HOME': '/Users/cltbld', 20:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:46 INFO - 'LOGNAME': 'cltbld', 20:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:46 INFO - 'MOZ_NO_REMOTE': '1', 20:09:46 INFO - 'NO_EM_RESTART': '1', 20:09:46 INFO - 'PAGER': '/bin/cat', 20:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:46 INFO - 'PWD': '/builds/slave/test', 20:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:46 INFO - 'SHELL': '/bin/bash', 20:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CNru181Ae/Listeners', 20:09:46 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 20:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:46 INFO - 'USER': 'cltbld', 20:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:46 INFO - 'XPC_FLAGS': '0x0', 20:09:46 INFO - 'XPC_SERVICE_NAME': '0', 20:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:46 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Zhlxcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:47 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-dF5yer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:47 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-uBQRDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:47 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-B2ppRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:47 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-BjBVT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:47 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Yby5kL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:47 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-HLRmrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:47 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Zwk2NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:47 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-LRSuVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:47 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-qt0m0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:47 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-fiZgoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-gAXrHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-zrh7xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-fUfHXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-8VQ_6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-tboGrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-ljsPFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:09:48 INFO - Running setup.py install for manifestparser 20:09:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:09:48 INFO - Running setup.py install for mozcrash 20:09:48 INFO - Running setup.py install for mozdebug 20:09:49 INFO - Running setup.py install for mozdevice 20:09:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Running setup.py install for mozfile 20:09:49 INFO - Running setup.py install for mozhttpd 20:09:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Running setup.py install for mozinfo 20:09:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Running setup.py install for mozInstall 20:09:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:09:49 INFO - Running setup.py install for mozleak 20:09:49 INFO - Running setup.py install for mozlog 20:09:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for moznetwork 20:09:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for mozprocess 20:09:50 INFO - Running setup.py install for mozprofile 20:09:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for mozrunner 20:09:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:09:50 INFO - Running setup.py install for mozscreenshot 20:09:50 INFO - Running setup.py install for moztest 20:09:51 INFO - Running setup.py install for mozversion 20:09:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:09:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:09:51 INFO - Cleaning up... 20:09:51 INFO - Return code: 0 20:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:51 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 0x1043edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a7247ab00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041cbd30>, '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 0x1040f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c0be8>, '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.FBst7QKjWE/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.3CNru181Ae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 20:09:51 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 20:09:51 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 20:09:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FBst7QKjWE/Render', 20:09:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:51 INFO - 'HOME': '/Users/cltbld', 20:09:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:51 INFO - 'LOGNAME': 'cltbld', 20:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:51 INFO - 'MOZ_NO_REMOTE': '1', 20:09:51 INFO - 'NO_EM_RESTART': '1', 20:09:51 INFO - 'PAGER': '/bin/cat', 20:09:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:51 INFO - 'PWD': '/builds/slave/test', 20:09:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:51 INFO - 'SHELL': '/bin/bash', 20:09:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CNru181Ae/Listeners', 20:09:51 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 20:09:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:51 INFO - 'USER': 'cltbld', 20:09:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:51 INFO - 'XPC_FLAGS': '0x0', 20:09:51 INFO - 'XPC_SERVICE_NAME': '0', 20:09:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:09:51 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-7JwQF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:09:51 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Yvjop6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:09:51 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-tTU6Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:09:51 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-8nkNRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:09:51 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)) 20:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:09:51 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-pDhwfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:09:52 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-MD5ix5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:09:52 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-_DeFZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:09:52 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-LtRTDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:09:52 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Ef9cxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:09:52 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-u9W_MP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:09:52 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-bYLcfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:09:52 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-guJSa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:09:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:09:52 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-UseMUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:09:52 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)) 20:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:09:52 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-sxEJNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:09:53 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)) 20:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:53 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-gw4AGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:09:53 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)) 20:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:09:53 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-10A2jM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:09:53 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)) 20:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:09:53 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Ah_F9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:09:53 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)) 20:09:53 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)) 20:09:53 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)) 20:09:53 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)) 20:09:53 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)) 20:09:53 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)) 20:09:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:09:53 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 20:09:53 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 20:09:53 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 20:09:53 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 20:09:53 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 20:09:53 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 20:09:55 INFO - Downloading blessings-1.6.tar.gz 20:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:09:56 INFO - Installing collected packages: blessings 20:09:56 INFO - Running setup.py install for blessings 20:09:56 INFO - Successfully installed blessings 20:09:56 INFO - Cleaning up... 20:09:56 INFO - Return code: 0 20:09:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:56 INFO - Reading from file tmpfile_stdout 20:09:56 INFO - Current package versions: 20:09:56 INFO - blessings == 1.6 20:09:56 INFO - blobuploader == 1.2.4 20:09:56 INFO - docopt == 0.6.1 20:09:56 INFO - functools32 == 3.2.3-2 20:09:56 INFO - jsonschema == 2.5.1 20:09:56 INFO - manifestparser == 1.1 20:09:56 INFO - mozInstall == 1.12 20:09:56 INFO - mozcrash == 1.0 20:09:56 INFO - mozdebug == 0.1 20:09:56 INFO - mozdevice == 0.49 20:09:56 INFO - mozfile == 1.2 20:09:56 INFO - mozhttpd == 0.7 20:09:56 INFO - mozinfo == 0.9 20:09:56 INFO - mozleak == 0.1 20:09:56 INFO - mozlog == 3.4 20:09:56 INFO - moznetwork == 0.27 20:09:56 INFO - mozprocess == 0.24 20:09:56 INFO - mozprofile == 0.28 20:09:56 INFO - mozrunner == 6.13 20:09:56 INFO - mozscreenshot == 0.1 20:09:56 INFO - mozsystemmonitor == 0.3 20:09:56 INFO - moztest == 0.8 20:09:56 INFO - mozversion == 1.4 20:09:56 INFO - psutil == 3.1.1 20:09:56 INFO - requests == 1.2.3 20:09:56 INFO - wsgiref == 0.1.2 20:09:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:57 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 0x1043edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a7247ab00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041cbd30>, '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 0x1040f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c0be8>, '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.FBst7QKjWE/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.3CNru181Ae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 20:09:57 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 20:09:57 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 20:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FBst7QKjWE/Render', 20:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:57 INFO - 'HOME': '/Users/cltbld', 20:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:57 INFO - 'LOGNAME': 'cltbld', 20:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:57 INFO - 'MOZ_NO_REMOTE': '1', 20:09:57 INFO - 'NO_EM_RESTART': '1', 20:09:57 INFO - 'PAGER': '/bin/cat', 20:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:57 INFO - 'PWD': '/builds/slave/test', 20:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:57 INFO - 'SHELL': '/bin/bash', 20:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CNru181Ae/Listeners', 20:09:57 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 20:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:57 INFO - 'USER': 'cltbld', 20:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:57 INFO - 'XPC_FLAGS': '0x0', 20:09:57 INFO - 'XPC_SERVICE_NAME': '0', 20:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:57 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)) 20:09:57 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)) 20:09:57 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)) 20:09:57 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)) 20:09:57 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)) 20:09:57 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)) 20:09:57 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)) 20:09:57 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)) 20:09:57 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)) 20:09:57 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)) 20:09:57 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)) 20:09:57 INFO - Cleaning up... 20:09:57 INFO - Return code: 0 20:09:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:09:58 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 0x1043edb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043f0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8a7247ab00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1041cbd30>, '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 0x1040f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c0be8>, '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.FBst7QKjWE/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.3CNru181Ae/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 20:09:58 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 20:09:58 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 20:09:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FBst7QKjWE/Render', 20:09:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:09:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:09:58 INFO - 'HOME': '/Users/cltbld', 20:09:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:09:58 INFO - 'LOGNAME': 'cltbld', 20:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:09:58 INFO - 'MOZ_NO_REMOTE': '1', 20:09:58 INFO - 'NO_EM_RESTART': '1', 20:09:58 INFO - 'PAGER': '/bin/cat', 20:09:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:09:58 INFO - 'PWD': '/builds/slave/test', 20:09:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:09:58 INFO - 'SHELL': '/bin/bash', 20:09:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CNru181Ae/Listeners', 20:09:58 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 20:09:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:09:58 INFO - 'USER': 'cltbld', 20:09:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:09:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:09:58 INFO - 'XPC_FLAGS': '0x0', 20:09:58 INFO - 'XPC_SERVICE_NAME': '0', 20:09:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:09:58 INFO - Cleaning up... 20:09:58 INFO - Return code: 0 20:09:58 INFO - Running post-action listener: _resource_record_post_action 20:09:58 INFO - Running post-action listener: _start_resource_monitoring 20:09:58 INFO - Starting resource monitoring. 20:09:58 INFO - [mozharness: 2017-03-31 03:09:58.567407Z] Finished create-virtualenv step (success) 20:09:58 INFO - [mozharness: 2017-03-31 03:09:58.568224Z] Running install step. 20:09:58 INFO - Running pre-action listener: _resource_record_pre_action 20:09:58 INFO - Running main action method: install 20:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:09:58 INFO - Reading from file tmpfile_stdout 20:09:58 INFO - Detecting whether we're running mozinstall >=1.0... 20:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:09:58 INFO - Reading from file tmpfile_stdout 20:09:58 INFO - Output received: 20:09:58 INFO - Usage: mozinstall [options] installer 20:09:58 INFO - Options: 20:09:58 INFO - -h, --help show this help message and exit 20:09:58 INFO - -d DEST, --destination=DEST 20:09:58 INFO - Directory to install application into. [default: 20:09:58 INFO - "/builds/slave/test"] 20:09:58 INFO - --app=APP Application being installed. [default: firefox] 20:09:58 INFO - mkdir: /builds/slave/test/build/application 20:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 20:10:13 INFO - Reading from file tmpfile_stdout 20:10:13 INFO - Output received: 20:10:13 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:10:13 INFO - Running post-action listener: _resource_record_post_action 20:10:13 INFO - [mozharness: 2017-03-31 03:10:13.720520Z] Finished install step (success) 20:10:13 INFO - [mozharness: 2017-03-31 03:10:13.720651Z] Running run-tests step. 20:10:13 INFO - Running pre-action listener: _resource_record_pre_action 20:10:13 INFO - Running main action method: run_tests 20:10:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:10:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:10:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:10:13 INFO - 2017-03-30 20:10:13.735 screenresolution[1974:17397] starting screenresolution argv=screenresolution get 20:10:13 INFO - 2017-03-30 20:10:13.737 screenresolution[1974:17397] Display 0: 1600x1200x32@60 20:10:13 INFO - 2017-03-30 20:10:13.743 screenresolution[1975:17399] starting screenresolution argv=screenresolution list 20:10:13 INFO - Available Modes on Display 0 20:10:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:10:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:10:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:10:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:10:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:10:13 INFO - Intel Iris: 20:10:13 INFO - Chipset Model: Intel Iris 20:10:13 INFO - Type: GPU 20:10:13 INFO - Bus: Built-In 20:10:13 INFO - VRAM (Dynamic, Max): 1536 MB 20:10:13 INFO - Vendor: Intel (0x8086) 20:10:13 INFO - Device ID: 0x0a2e 20:10:13 INFO - Revision ID: 0x0009 20:10:13 INFO - Displays: 20:10:13 INFO - Display: 20:10:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:10:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:10:13 INFO - Display Serial Number: 1600x1200 60 20:10:13 INFO - Main Display: Yes 20:10:13 INFO - Mirror: Off 20:10:13 INFO - Online: Yes 20:10:13 INFO - Rotation: Supported 20:10:13 INFO - Return code: 0 20:10:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:10:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:10:13 INFO - Python 2.7.3 20:10:13 INFO - Return code: 0 20:10:13 INFO - grabbing minidump binary from tooltool 20:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:10:13 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 0x1041cbd30>, '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 0x1040f2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1041c0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:10:13 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 20:10:13 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 20:10:13 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 20:10:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:10:14 INFO - Return code: 0 20:10:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:10:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:10:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:10:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:10:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:10:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--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 20:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0148 --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 20:10:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FBst7QKjWE/Render', 20:10:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:10:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:10:14 INFO - 'HOME': '/Users/cltbld', 20:10:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:10:14 INFO - 'LOGNAME': 'cltbld', 20:10:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:10:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:10:14 INFO - 'MOZ_NO_REMOTE': '1', 20:10:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:10:14 INFO - 'NO_EM_RESTART': '1', 20:10:14 INFO - 'PAGER': '/bin/cat', 20:10:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:10:14 INFO - 'PWD': '/builds/slave/test', 20:10:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:10:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:10:14 INFO - 'SHELL': '/bin/bash', 20:10:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CNru181Ae/Listeners', 20:10:14 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 20:10:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:10:14 INFO - 'USER': 'cltbld', 20:10:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:10:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:10:14 INFO - 'XPC_FLAGS': '0x0', 20:10:14 INFO - 'XPC_SERVICE_NAME': '0', 20:10:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:10:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--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 20:10:14 INFO - mozversion application_buildid: 20170330191006 20:10:14 INFO - mozversion application_changeset: 14b6ab023dec51a423a034aa8f307c56776d59c1 20:10:14 INFO - mozversion application_display_name: Firefox 20:10:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:10:14 INFO - mozversion application_name: Firefox 20:10:14 INFO - mozversion application_remotingname: firefox 20:10:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:10:14 INFO - mozversion application_vendor: Mozilla 20:10:14 INFO - mozversion application_version: 53.0 20:10:14 INFO - mozversion platform_buildid: 20170330191006 20:10:14 INFO - mozversion platform_changeset: 14b6ab023dec51a423a034aa8f307c56776d59c1 20:10:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:10:14 INFO - mozversion platform_version: 53.0 20:10:14 INFO - using testdate: 1490929814 20:10:14 INFO - actual date: 1490929814 20:10:14 INFO - starting webserver on 'localhost:53138' 20:10:14 INFO - SUITE-START | Running 2 tests 20:10:14 INFO - TEST-START | dromaeo_css 20:10:14 INFO - operating with platform_type : mac_ 20:10:14 INFO - Initialising browser for dromaeo_css test... 20:10:14 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmp3UQsBU/profile http://localhost:53138/getInfo.html) 20:10:16 INFO - PROCESS | 1985 | __metrics Screen width/height:1600/1200 20:10:16 INFO - PROCESS | 1985 | colorDepth:24 20:10:16 INFO - PROCESS | 1985 | Browser inner width/height: 1024/689 20:10:16 INFO - PROCESS | 1985 | __metrics 20:10:16 INFO - PROCESS | 1985 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:10:16 INFO - PROCESS | 1985 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:10:17 INFO - TEST-INFO | 1985: exit 0 20:10:17 INFO - Browser initialized. 20:10:17 INFO - Running cycle 1/1 for dromaeo_css test... 20:10:17 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmp3UQsBU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:29 INFO - PROCESS | 1988 | RSS: Main: 163336192 20:10:29 INFO - PROCESS | 1988 | 20:13:31 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53138/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53138/tests/dromaeo/cssquery-ext.html) 20:13:33 INFO - PROCESS | 1988 | RSS: Main: 321146880 20:13:33 INFO - PROCESS | 1988 | 20:16:36 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53138/tests/dromaeo/cssquery-ext.html (next: http://localhost:53138/tests/dromaeo/cssquery-jquery.html) 20:16:37 INFO - PROCESS | 1988 | RSS: Main: 303661056 20:16:37 INFO - PROCESS | 1988 | 20:19:39 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53138/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53138/tests/dromaeo/cssquery-mootools.html) 20:19:40 INFO - PROCESS | 1988 | RSS: Main: 281014272 20:19:40 INFO - PROCESS | 1988 | 20:22:42 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53138/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53138/tests/dromaeo/cssquery-prototype.html) 20:22:43 INFO - PROCESS | 1988 | RSS: Main: 282189824 20:22:43 INFO - PROCESS | 1988 | 20:25:46 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53138/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53138/tests/dromaeo/cssquery-yui.html) 20:25:47 INFO - PROCESS | 1988 | RSS: Main: 274989056 20:25:47 INFO - PROCESS | 1988 | 20:28:50 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:53138/tests/dromaeo/cssquery-yui.html (next: http://localhost:53138/tests/dromaeo/cssquery-dojo.html) 20:28:50 INFO - PROCESS | 1988 | RSS: Main: 479842304 20:28:50 INFO - PROCESS | 1988 | 20:28:50 INFO - PROCESS | 1988 | __start_tp_report 20:28:50 INFO - PROCESS | 1988 | _x_x_mozilla_page_load 20:28:50 INFO - PROCESS | 1988 | _x_x_mozilla_page_load_details 20:28:50 INFO - PROCESS | 1988 | |i|pagename|runs| 20:28:50 INFO - PROCESS | 1988 | |0;dojo.html;3352.664733526647;3371.089805752447;3375.4430518964373;3391.508231306459;3436.1409647588102;5750.166225897247;5793.971030144843;5798.652080875145;5817.476427121558;5820.534357251415;5780.739866705998;5825.359210486843;5854.18041474194;5855.23881895353;5880.411958804118;5234.330491449369;5244.396894357141;5262.315898933133;5284.577233821305;5293.68237905725;4781.976090119544;4988.152014157602;5205.063088644042;5212.4266330703595;5319.840404787863;5207.244949482323;5233.293505376763;5246.37043554772;5272.051030814452;5325.840224793243;5286.814961476349;5312.92030619541;5316.680999140025;5321.308229930123;5343.866403339928;5173.586113110942;5221.973890130525;5225.294585230983;5257.842264732064;5299.152135658276;5670.5463562914865;5707.571932105108;5730.856728581777;5739.885202295931;5785.623934444247;6291.182146320994;6318.71565779541;6332.461740752042;6334.049892516114;6352.523560732963;6239.906401403982;6280.685965701697;6283.968580157116;6296.118543403927;6297.590656607352;5723.484886360206;5799;5821.941780582225;5929.347771745104;5929.673867937262;6247.843803904939;6305.590136641195;6316.399942005502;6378.330275321117;6403.551751377358;6199.776116419436;6242.75028998844;6253.218347706536;6263.279722831932;6267.1539342189135;6227.252729672468;6307.9369206308265;6312.084747711556;6313.936860631335;6316.463100636497;5185.377754669464;6143.726821076141;6208.068789681584;6227.532935029891;6283.748650053946;6323.272823625342;6335.873282534323;6353.809385718436;6359.745610175633;6370.203724534434;4952.851414457572;4953.628477864175;4990.875228119254;4997.775100120503;5012.398512178489;3662.560492740888;4418.55814418562;4433.046894917608;4437.156940181355;4526.502084770673;5787.681677507693;5792.362840087587;5822.388649191858;5845.152452894306;5858.736356863951;6301.464375528039;6312.274088479791;6322.936770632326;6330.335314791972;6347.5239357047485;5671.801486947937;5680.6591604503865;5754.338251101093;5766.94233057664;5771.624844385102;5435.483629055233;5453.754581043862;5477.178423236546;5483.835484935458;5535.723213839292;6273.560850740496;6289.779857705142;6290.087937248982;6311.463525600284;6343.904841427382;5179.741012949262;6302.65335406557;6320.810375688737;6340.334264902119;6347.460465860268;6163.476104531165;6272.372762723691;6274.215723034621;6274.341194174728;6294.15028971083;6271.96864015677;6286.18279623646;6303.149074874833;6318.557700960889;6339.904901426575;6231.594946328655;6282.465990390868;6287.874242515032;6301.936980630135;6307.779227727007;4991.376077990251;6068.6358818471035;6136.2636483622255;6170;6238.438540531374;5964.4035596441745;6208.81373558794;6213.751449941951;6216.968915155395;6227.96886015567;6091.390860913873;6095.786647467317;6106.969465152646;6113.786017489367;6136.018237082224;6064.241969753781;6126.693665316628;6183.598066125687;6231.9688401557705;6241.063840423973;6025.337212906665;6036.879262414815;6036.879262414815;6116.229271450518;6145.539084568586 20:28:50 INFO - PROCESS | 1988 | |1;ext.html;446.1879379529256;461.91685496610614;510.26012282190834;518.1217835768373;527.0302643136628;32719.1820204495;41708.37437438441;44089.559104408945;44122.896927576825;46286;45332.77333613327;45816.08367832642;45820.541794582045;45901.540984590145;45966.62100136993;8756.737297881074;9424.623015079424;9640.469774162435;9818.656347027856;9822.361546499491;8898.065703101178;9139.634414623408;9147.634094636207;9217.631294748202;9228.815423691522;11786.705332366717;12087.335196564185;12110.576129835457;12241.571544995926;12250.387480625977;11920.940395298012;12027.27836329823;12040.81938770919;12049.93975030128;12073.698157546043;11751.294922304603;11835.230710003822;11838.171328007043;11839.822402663967;11875.34685592292;42112.78943605293;42341.57658423407;42440.7267781964;42467.36298955518;42587.36118958218;3478.7043101336417;4034.7579145251084;4086.7956602169775;4144.378343248507;4151.982764222755;30752.53871191934;31287.84356078205;32597.27864641905;32779;32814;3262.673732626742;3289.555909952174;3403.2002479417315;3410.5225268462436;3519.9120021999397;348547;430533.99999999686;430636;430802;432738;67886;68006.31993679999;68037.65981170062;68461.65769171123;68636.6568167156;71211;71245.93131103038;71259;71424;71504;17632;17637.647247055243;17984.2806287747;18395.356162534248;18417.355392561196;13912.791308130387;14011.649708757363;14019;14020.789688154686;14022.088564243291;16234.188290585424;16582.08798516069;17794.02132882678;18646.81353186478;18685.81314186868;6061.424164704346;6108.633481991094;7146.428285737128;7170.458351454462;7249.238829922888;875.3391189651772;879.4283715584921;902.4675441489553;913.3287034029983;940.3934462271797;25514.362140946625;30162.24594385114;30329;31013.534796978063;32210.83894580512;912.5528491039342;954.2938225712923;1064.2018486135398;1073.7959787640323;1145.4158379226487;11862;13719.931400343134;14336.139831610137;14980.92509537467;15905.602359940862;640095;642281;643943;644175;645242;58236;58458.123128153115;58475.83048339094;58482;58738.70630646819;1346.367207412534;1391.6242614494233;1433.1257932661276;1472.2565104622097;1483.3028476615973;23747.406314841577;24075.518489629758;29546.704532954394;30379.2405189872;31072;49304.26043609277;49984;50001.74995624993;50140.997180056926;50236.748816255684;530428;531873;533505;533562;534245.3287733536;23684;24113.914873831072;26106.73893261043;26556.33609159709;26562;46152.7692361536;46184;46362.76818615885;48181.27728084011;48474.27208773105;30429.86990910615;31413.685863141076;32261.35477290488;32977.67022329842;33075;31945.520817188226;32401.189970250933;32943.67056329502;33052.33895322128;33071.66928330782;35485.82257088801;37591.24817503689;38360.61639383682;38384.808075959445;38654.80672596619;25369.365765856;31946.84026579852;31959.721611135294;33077.338453231285;33176.004719857476;23599.46008098799;25025;25265.494690105726;25364.492710146063;25733.613995789703 20:28:50 INFO - PROCESS | 1988 | |2;jquery.html;342.6487849953797;389.7408223531352;394.1427395414972;400.14145436401236;425.156065210557;15767.448139315125;21224.4693882653;21999.68001919886;22798.544029119428;22822.65766013509;22766.975486103125;22771.544569108606;22972;23758.40603984897;23947.640785388234;6013.579049466539;6342.365763423667;6343.460805831487;6344.555881088326;6345.270293916189;6106.023036314191;6137.539684523656;6221.844453888666;6251.531135164858;6268.216472940882;6098.512119030489;6141.815745527641;6232.626042437469;6249.3438188990185;6259.937400625981;5962.195103661015;6177.938220617803;6254.530910181732;6257.499400047986;6262.12330273762;5273.314469119028;5363.973180134074;5383.353997520284;5494.780208791643;5505.614606977513;27382.630868456497;28423.57364639532;28455.430891382057;28497.287567810763;28757.281067973257;2841.9395937945033;2854.7631753504975;2902.201894479014;2908.6945870683485;2915.318819583643;15367.385304587802;15614.687706245924;15617.687646247012;15708.764368534481;16121.193940302937;1832.8900265984084;1892.4417296897448;1893.2048539613395;1893.640208360421;1914.8851068935908;129783;136604.31697841547;137745.311273443;138207.30896345555;139246;9762;11798.46906889192;11886.702832429259;12095.75808483843;12241.143119981516;13991.16053036821;14734.63163420923;15595.61010974712;15646.061236325857;15661.216939152997;8802.295816334678;8971.878515185601;9124.726258212264;9449.669261575811;9636.518174091267;9492.382995105434;9499;9503.57233924475;9505;9721.222302215805;6440.871182576322;6821.3519715626935;6916.20463646687;7227.960271990163;7660.578668173192;1676.7568702538063;1798.3890651696363;1830.401972578754;1964.2143142743016;1980;1079.1259080145107;1096.2600244834705;1099.6206308823444;1112.7885701716648;1149.9482523286472;18729.344472943383;22406.84943766584;23073.653895191586;23630;23722.288331350086;693.0747452151334;1097.665212110314;1104.6575561575937;1133.7505748735266;1148.362658724416;6476.89892718239;7049.118860142482;7499.512531685423;7507;7530.795072788327;764284;766658;772879;773265;801275;157866;159011;161648.06044485274;162189;165127.1743641298;948.3266880514774;1054.778496515725;1075.7687097274124;1099.373357186396;1104.2889705772309;12903.612891613267;13104.737905242033;13290.86709132935;13353.599392018255;13495;43441;55147.17279240895;55423.44576554344;57613;57887.710561446926;86343.13656863602;87043;88698;88843;90449.54775226081;7814.843703126019;8660.610272537877;8891;8996.695479155616;9155.13026262504;8494.532800695773;8948.865767013369;9593;12921.547745828851;13482.662933426744;8141.8778718320455;8155.735860941563;8162;8172.959135204286;8195.344372450309;6165.475934545614;7454.701811927463;7706.884396733942;8003.879941800761;8171.223733745284;6913.274106218774;7249.311315425026;8525.658973641233;8656.26421754158;8657.610407531802;11475.770484590428;12970.610881673565;13484.739543302245;13799.102188540519;13859.584212473643;12224.75550489003;12304.692382690504;12310.322932238812;12319.87680123223;12418.875811241773 20:28:50 INFO - PROCESS | 1988 | |3;mootools.html;1462.8317743459502;1486.0415032304163;1489.568025272671;1511.5314252581697;1516.052467207995;7549.886751698715;7882.251186137322;8158.224968627986;8618.396712230146;8619.224269815715;7762.534247945127;7850.411219158572;7853.136155022943;7857.567833769141;8129.6748130074875;2327.359976006599;2386.6658667786523;2393.7366889642126;2394.030417680842;2394.1381102802975;2299.41364951937;2401.3156250468533;2410.3371572817528;2413.1553956115395;2419.6733440985417;1970.5861769028522;2197.3188311623367;2286.5312610914807;2364.680768096302;2398.2925037114005;2369.052379048386;2385.022140922222;2390.8685022323766;2391.0196819304;2395.149721848736;2350.7061617297836;2355.658429527726;2372.2764556810166;2379.976200237993;2412.2522018174423;8575.099614540508;8635.870461943075;8637.611307491115;8646.43798153118;8656.523891185981;4344.283193273106;4801.7995501124715;5167.741612919339;5386.8383948481605;5391.029614669358;3063.433264846011;3426.2119712466274;3644.653757892996;3695.1685870679153;3715.3312403767313;1191.7020744813797;1232.3283810323396;1238.2384833327528;1310.6264714556305;1314.434793038993;10956.178286628534;11071.114310855111;11084.556617735361;11088.55645774176;11123.72190695231;4604.217283061887;4623.537646235417;4745.145873742759;4847.224444088929;4853.077915196172;9744;9750.707478775648;9753.414795112316;9757.268204884662;9776.657816976372;5393.541548968303;5451.64564303319;5453.045716999509;5455.781768729285;5466.644668096561;4880.194767863263;4904.141775189399;4973.577245934064;4983.476734942851;4991.376077990251;3853.7109716771356;3887.922241555153;3971.841126354971;4003.679705623543;4010.0977280111742;1271.4087949103712;1277.7061275906594;1285.1453783234044;1297.5264028629672;1310.1549500572078;928.2852203803034;937.6811883959487;949.8765160529225;962.1869520255373;1010.3533738407425;5683.374828768832;5714.685692286964;5764.164196191613;5772.307323121252;5889.3402940677515;573.1345668041205;581.3953488372131;583.3990989281048;587.8030859661976;590.9497692696083;3854.9807250963568;3867.8646247381207;3897.4738410314812;3907.866718651559;3921.3333733265413;9567.665131720356;10152.492375381202;10169.54237059334;10174.796504069876;10190.235732320105;9863.01369863008;10116.24128190374;10126.038026387481;10127.291089623803;10138.391696498235;7674.654640541189;7882.330001949898;7914.327282180964;7993.320567751806;8033.5179889205665;5409.134538473825;5995.88008239824;6010.729517171825;6115.571909966259;6125.816225513242;7775.961120194363;9079.500627465553;9435.669751558662;9498.762530936781;9631;9629.133377996013;9661.758456038655;9666.468344240853;9752.024797520191;9824.887649155466;7357.742479013209;7470.8879366810625;7490.812729681802;7603.543787372775;7871.134175240833;8039.437239393186;8133.146019668086;8181.509109453452;8266.13205613426;8275.95862020686;7023.403010744144;7067.540609860343;7099.006139140628;7115.466340024623;7153.248908864703;5891.646501209942;6838.350356716104;6942.548734332252;6989.895151572832;7059.152901651834;6420.293767685457;6555.70499327541;6627.37039981201;6644.136262285871;6647.567908085959;5119.6416250862085;5160.432352441153;5184.844454666366;5227.843164705065;5253.816116435906;5105.463926287686;5157.226416037624;5237.554807841376;5299.364076310867;5387.191921211693 20:28:50 INFO - PROCESS | 1988 | |4;prototype.html;364.38964734070424;369.6488336080722;374.6590602551678;385.8283064036501;388.65021480667394;4425.623821975136;4475.955240447594;5314.5748340132795;5316.574674026078;5472.315960504937;4648.885246884587;5153.959164093184;5255.842324730254;5260.8158714445;5262.500312351631;3489.633588473212;4139.19285739281;4164.479440069991;4200.264953633117;4215.831366745327;3651.6713495785375;4176.14389050244;4195.433616461769;4212.757236615206;4218.662506999448;3991.800409979504;4184.811683474236;4203.7057405981595;4212.347086201628;4232.174725928445;3656.012876523337;3855.7108216883566;3884.3202439573242;3897.4933258676474;4211.789410529476;3763.6424539668687;3765.924681506382;3776.282506323817;3788.7158463115375;3821.6560509553997;5137.537621614036;5253.474652534716;5265.157194981764;5274.784590472011;5339.9733001335135;4891.608671306287;4905.007945153454;4935.827246046407;4943.629227807893;4945.159322915113;5228.398734145584;5696.6866822324755;5718.399568045337;5746.281714785652;5774.97112514439;3911.5306163260307;4135.627793498599;4173.39485774564;4185.91628167438;4198.160367926427;5484.451554844563;5509.256250406224;5764.942350576483;5955.880882382371;6042.546808989343;3385.7122144617983;3763.7553559018575;4256.29771087767;4258.212230737324;4269.530351661315;3844.519435070616;4038.84892805549;4129.855455059059;4283.764392958417;4337.587929146726;3807.600201978808;4541.9545804542195;4831.347768051268;4871.196252618278;4892.730899800474;5046.394432668103;5709.8287051388525;5739.253896993364;5775.5668324875805;5777.508911742465;1113.7215696075982;1133.3992983718642;1192.9463174157183;1333.240053169684;1362.344751127385;887.4719541872576;968.7674958010027;995.4823491784232;1003.9899601004042;1008.2841182760176;4219.092895027584;5037.168867136881;5064.404712515546;5071.54356107952;5091.770870310845;4554.977225113853;4675.322078298627;5394.595405344615;5566.582506312043;5588.944110558924;4533.750643714628;4783.010618363523;4794.736289504111;4821.192052980133;5040.538243909298;2421.8425802322795;2624.6325514427995;2712.6707913122427;2786.801675279609;2905.6198305804573;5100.948990510122;5352.357717073898;5780.277465316835;5789.334226563999;5836.007878660638;5171.146760784503;5264.473552644705;5630.8613169320515;5690.577355661085;5693.373728889819;4547.954520454753;5177.524405544402;5445.957765837811;5728.455796699307;5741.799037033684;4935.950640493549;5039.571636410946;5114.33513643224;5533.889322213614;5554.777948851246;4786.58277569825;5027.572656324107;5043.722595257296;5483.8080667176455;5491.533219676372;5319.813806516753;5731.799387021434;5731.942680573307;5762.530554708523;5824.883502329845;4028.1943611277275;4032.0524676700365;4051.0480037190646;4055.7363771354767;4069.2471892699946;4357.324614684729;5421.539169170507;5549.472800083986;5840.678762668094;5900.64596124234;4116.403121547419;4750.572448479654;5096.668716533562;5448.509634132947;5548.9722551386985;4727.479977202436;5047.646664733434;5402.027635025733;5613.691246981455;5710.600257982068;4637.585536411427;5240.292560504283;5566.385748132996;5571.804986825442;5597.748101335368;5689.516391106802;5697.4587414195585;5716.828495145152;5744.443722543428;5745.597808153389;4672.5327467253;4760.88097797544;5347.304850369427;5658.755073883739;5679.551714312824 20:28:50 INFO - PROCESS | 1988 | |5;yui.html;735.7125031195404;742.3281929853481;746.8655641984448;865.7532603208085;887.5739644970414;13994.090384125026;14696.85303146971;14709.190994495326;14718.852811471883;14741.968062235648;14462.349194286257;14539.127652340867;14632.561023169323;14670;14677.26613669315;724.1961422820665;743.1305372713911;896.8520194167954;906.5965645287849;908.2189317187214;734.3501001613557;879.9076097009818;887.7248053103526;895.2703546609525;915.0300681277834;962.4033099478333;963.0177219236409;964.3056998960737;966.21253678252;966.6616684160558;918.7427520294328;955.7801705607679;958.5542722634009;960.9519524023771;963.1572374172564;690.4062506244626;691.6541729135432;718.1059580821858;719.6186021408662;721.9639816862766;15158.545243642599;15527.844721552752;15571.37714491419;15844.44544440939;16099.275532601061;14256.643583910381;14411;14847.851521484756;14974.101553906801;15357.308921098578;11625.6512304631;11638.941805291004;11781.352025638587;11857.407129643483;12061.935637853563;3837.213371258885;3837.9424308635394;3879.9806000970098;3927.3716205407;4072.5316588592395;100224.49887750515;103989;105091.47454262679;107813;108455.91544084538;10563.961759234322;10951;11108.833367499494;11571.270849526847;11929.821052684216;22877.428064298525;23235.186768463023;23260;23267.767322326898;23297.18459853897;7403.296686814744;7572.242775722384;7683.116441609286;7744.728934487379;7801.531908085533;4355.477342718894;4407.765825568846;4507.932381014288;4513.097380523843;4653.302004699322;3631.2374401375478;3667.8349474273723;3727.7390582658954;3731.384321586962;3759;676.6853413162903;685.4824607421365;692.7021380806302;704.475166001322;704.9295070493013;652.7062821730241;653.6534738438831;661.2990230355838;670.6445583840572;678.5080816408065;9833.606655733834;10206.4386458744;10223.591056357662;10347.482625868677;10453.372797632166;654.1430725749284;675.5045174364514;681.3186813186813;701.4423533291045;703.4442790195791;4902.779374928136;4912.38595175603;4929.950700493021;4945.2582112683385;4946.826861059918;80888.59555702301;103384.48307758564;103583.96416035894;105423.47288263509;110385;70992.64503677448;87827;88316;89141.55429222812;92345.61235101176;64630.67684661547;77542;81795.18204817876;82692;84822;9628.47043412619;9677.612895484102;9698.321117521706;9700.27247956392;9718.514074296116;49724.50826475211;50195.74902125466;50366;51205.743971281394;51490.74254628703;63948.68025659842;70155.64922175357;70889;72648;72837.6358118206;11144.777104457704;11625.709357265798;11814.881851181379;12411.131220814455;13472.86527134716;14616.415343386145;14864.851351486346;15843.683126337179;16406.753898691768;16422.343106275614;13867.653308667364;14539.709205816036;14869.033512821632;15022;15191.468298609496;11415.714607134556;13850.515231966832;13854.65363365924;14800.703985920436;14982.475613353481;13587.363004477345;13983.720325593227;14124.78812817788;14496.85503144955;14512.492062777752;9613.14407817449;10387.84418233712;10395;10501.422421766876;10555.313904596176;8547.74356769298;11282.51784607385;11360.772784544428;11651.475683594428;12033.819492707442 20:28:50 INFO - PROCESS | 1988 | __end_tp_report 20:28:50 INFO - PROCESS | 1988 | __start_cc_report 20:28:50 INFO - PROCESS | 1988 | _x_x_mozilla_cycle_collect,1648 20:28:50 INFO - PROCESS | 1988 | __end_cc_report 20:28:50 INFO - PROCESS | 1988 | __startTimestamp1490930930525__endTimestamp 20:28:50 INFO - PROCESS | 1988 | 20:28:50 INFO - PROCESS | 1988 | ------- Summary: start ------- 20:28:50 INFO - PROCESS | 1988 | Number of tests: 6 20:28:50 INFO - PROCESS | 1988 | 20:28:50 INFO - PROCESS | 1988 | [#0] dojo.html Cycles:165 Average:5784.99 Median:6064.24 stddev:667.73 (11.0%) stddev-sans-first:641.94 20:28:50 INFO - PROCESS | 1988 | Values: 3352.7 3371.1 3375.4 3391.5 3436.1 5750.2 5794.0 5798.7 5817.5 5820.5 5780.7 5825.4 5854.2 5855.2 5880.4 5234.3 5244.4 5262.3 5284.6 5293.7 4782.0 4988.2 5205.1 5212.4 5319.8 5207.2 5233.3 5246.4 5272.1 5325.8 5286.8 5312.9 5316.7 5321.3 5343.9 5173.6 5222.0 5225.3 5257.8 5299.2 5670.5 5707.6 5730.9 5739.9 5785.6 6291.2 6318.7 6332.5 6334.0 6352.5 6239.9 6280.7 6284.0 6296.1 6297.6 5723.5 5799.0 5821.9 5929.3 5929.7 6247.8 6305.6 6316.4 6378.3 6403.6 6199.8 6242.8 6253.2 6263.3 6267.2 6227.3 6307.9 6312.1 6313.9 6316.5 5185.4 6143.7 6208.1 6227.5 6283.7 6323.3 6335.9 6353.8 6359.7 6370.2 4952.9 4953.6 4990.9 4997.8 5012.4 3662.6 4418.6 4433.0 4437.2 4526.5 5787.7 5792.4 5822.4 5845.2 5858.7 6301.5 6312.3 6322.9 6330.3 6347.5 5671.8 5680.7 5754.3 5766.9 5771.6 5435.5 5453.8 5477.2 5483.8 5535.7 6273.6 6289.8 6290.1 6311.5 6343.9 5179.7 6302.7 6320.8 6340.3 6347.5 6163.5 6272.4 6274.2 6274.3 6294.2 6272.0 6286.2 6303.1 6318.6 6339.9 6231.6 6282.5 6287.9 6301.9 6307.8 4991.4 6068.6 6136.3 6170.0 6238.4 5964.4 6208.8 6213.8 6217.0 6228.0 6091.4 6095.8 6107.0 6113.8 6136.0 6064.2 6126.7 6183.6 6232.0 6241.1 6025.3 6036.9 6036.9 6116.2 6145.5 20:28:50 INFO - PROCESS | 1988 | 20:28:50 INFO - PROCESS | 1988 | [#1] ext.html Cycles:180 Average:67370.39 Median:19502.87 stddev:143848.34 (737.6%) stddev-sans-first:144164.11 20:28:50 INFO - PROCESS | 1988 | Values: 446.2 461.9 510.3 518.1 527.0 32719.2 41708.4 44089.6 44122.9 46286.0 45332.8 45816.1 45820.5 45901.5 45966.6 8756.7 9424.6 9640.5 9818.7 9822.4 8898.1 9139.6 9147.6 9217.6 9228.8 11786.7 12087.3 12110.6 12241.6 12250.4 11920.9 12027.3 12040.8 12049.9 12073.7 11751.3 11835.2 11838.2 11839.8 11875.3 42112.8 42341.6 42440.7 42467.4 42587.4 3478.7 4034.8 4086.8 4144.4 4152.0 30752.5 31287.8 32597.3 32779.0 32814.0 3262.7 3289.6 3403.2 3410.5 3519.9 348547.0 430534.0 430636.0 430802.0 432738.0 67886.0 68006.3 68037.7 68461.7 68636.7 71211.0 71245.9 71259.0 71424.0 71504.0 17632.0 17637.6 17984.3 18395.4 18417.4 13912.8 14011.6 14019.0 14020.8 14022.1 16234.2 16582.1 17794.0 18646.8 18685.8 6061.4 6108.6 7146.4 7170.5 7249.2 875.3 879.4 902.5 913.3 940.4 25514.4 30162.2 30329.0 31013.5 32210.8 912.6 954.3 1064.2 1073.8 1145.4 11862.0 13719.9 14336.1 14980.9 15905.6 640095.0 642281.0 643943.0 644175.0 645242.0 58236.0 58458.1 58475.8 58482.0 58738.7 1346.4 1391.6 1433.1 1472.3 1483.3 23747.4 24075.5 29546.7 30379.2 31072.0 49304.3 49984.0 50001.7 50141.0 50236.7 530428.0 531873.0 533505.0 533562.0 534245.3 23684.0 24113.9 26106.7 26556.3 26562.0 46152.8 46184.0 46362.8 48181.3 48474.3 30429.9 31413.7 32261.4 32977.7 33075.0 31945.5 32401.2 32943.7 33052.3 33071.7 35485.8 37591.2 38360.6 38384.8 38654.8 25369.4 31946.8 31959.7 33077.3 33176.0 23599.5 25025.0 25265.5 25364.5 25733.6 20:28:50 INFO - PROCESS | 1988 | 20:28:50 INFO - PROCESS | 1988 | [#2] jquery.html Cycles:180 Average:41878.96 Median:391.94 stddev:129272.65 (32982.6%) stddev-sans-first:129597.67 20:28:50 INFO - PROCESS | 1988 | Values: 342.6 389.7 394.1 400.1 425.2 15767.4 21224.5 21999.7 22798.5 22822.7 22767.0 22771.5 22972.0 23758.4 23947.6 6013.6 6342.4 6343.5 6344.6 6345.3 6106.0 6137.5 6221.8 6251.5 6268.2 6098.5 6141.8 6232.6 6249.3 6259.9 5962.2 6177.9 6254.5 6257.5 6262.1 5273.3 5364.0 5383.4 5494.8 5505.6 27382.6 28423.6 28455.4 28497.3 28757.3 2841.9 2854.8 2902.2 2908.7 2915.3 15367.4 15614.7 15617.7 15708.8 16121.2 1832.9 1892.4 1893.2 1893.6 1914.9 129783.0 136604.3 137745.3 138207.3 139246.0 9762.0 11798.5 11886.7 12095.8 12241.1 13991.2 14734.6 15595.6 15646.1 15661.2 8802.3 8971.9 9124.7 9449.7 9636.5 9492.4 9499.0 9503.6 9505.0 9721.2 6440.9 6821.4 6916.2 7228.0 7660.6 1676.8 1798.4 1830.4 1964.2 1980.0 1079.1 1096.3 1099.6 1112.8 1149.9 18729.3 22406.8 23073.7 23630.0 23722.3 693.1 1097.7 1104.7 1133.8 1148.4 6476.9 7049.1 7499.5 7507.0 7530.8 764284.0 766658.0 772879.0 773265.0 801275.0 157866.0 159011.0 161648.1 162189.0 165127.2 948.3 1054.8 1075.8 1099.4 1104.3 12903.6 13104.7 13290.9 13353.6 13495.0 43441.0 55147.2 55423.4 57613.0 57887.7 86343.1 87043.0 88698.0 88843.0 90449.5 7814.8 8660.6 8891.0 8996.7 9155.1 8494.5 8948.9 9593.0 12921.5 13482.7 8141.9 8155.7 8162.0 8173.0 8195.3 6165.5 7454.7 7706.9 8003.9 8171.2 6913.3 7249.3 8525.7 8656.3 8657.6 11475.8 12970.6 13484.7 13799.1 13859.6 12224.8 12304.7 12310.3 12319.9 12418.9 20:28:50 INFO - PROCESS | 1988 | 20:28:50 INFO - PROCESS | 1988 | [#3] mootools.html Cycles:180 Average:5539.99 Median:5343.10 stddev:3009.26 (56.3%) stddev-sans-first:3002.11 20:28:50 INFO - PROCESS | 1988 | Values: 1462.8 1486.0 1489.6 1511.5 1516.1 7549.9 7882.3 8158.2 8618.4 8619.2 7762.5 7850.4 7853.1 7857.6 8129.7 2327.4 2386.7 2393.7 2394.0 2394.1 2299.4 2401.3 2410.3 2413.2 2419.7 1970.6 2197.3 2286.5 2364.7 2398.3 2369.1 2385.0 2390.9 2391.0 2395.1 2350.7 2355.7 2372.3 2380.0 2412.3 8575.1 8635.9 8637.6 8646.4 8656.5 4344.3 4801.8 5167.7 5386.8 5391.0 3063.4 3426.2 3644.7 3695.2 3715.3 1191.7 1232.3 1238.2 1310.6 1314.4 10956.2 11071.1 11084.6 11088.6 11123.7 4604.2 4623.5 4745.1 4847.2 4853.1 9744.0 9750.7 9753.4 9757.3 9776.7 5393.5 5451.6 5453.0 5455.8 5466.6 4880.2 4904.1 4973.6 4983.5 4991.4 3853.7 3887.9 3971.8 4003.7 4010.1 1271.4 1277.7 1285.1 1297.5 1310.2 928.3 937.7 949.9 962.2 1010.4 5683.4 5714.7 5764.2 5772.3 5889.3 573.1 581.4 583.4 587.8 590.9 3855.0 3867.9 3897.5 3907.9 3921.3 9567.7 10152.5 10169.5 10174.8 10190.2 9863.0 10116.2 10126.0 10127.3 10138.4 7674.7 7882.3 7914.3 7993.3 8033.5 5409.1 5995.9 6010.7 6115.6 6125.8 7776.0 9079.5 9435.7 9498.8 9631.0 9629.1 9661.8 9666.5 9752.0 9824.9 7357.7 7470.9 7490.8 7603.5 7871.1 8039.4 8133.1 8181.5 8266.1 8276.0 7023.4 7067.5 7099.0 7115.5 7153.2 5891.6 6838.4 6942.5 6989.9 7059.2 6420.3 6555.7 6627.4 6644.1 6647.6 5119.6 5160.4 5184.8 5227.8 5253.8 5105.5 5157.2 5237.6 5299.4 5387.2 20:28:50 INFO - PROCESS | 1988 | 20:28:50 INFO - PROCESS | 1988 | [#4] prototype.html Cycles:180 Average:4519.33 Median:4944.39 stddev:1338.38 (27.1%) stddev-sans-first:1305.30 20:28:50 INFO - PROCESS | 1988 | Values: 364.4 369.6 374.7 385.8 388.7 4425.6 4476.0 5314.6 5316.6 5472.3 4648.9 5154.0 5255.8 5260.8 5262.5 3489.6 4139.2 4164.5 4200.3 4215.8 3651.7 4176.1 4195.4 4212.8 4218.7 3991.8 4184.8 4203.7 4212.3 4232.2 3656.0 3855.7 3884.3 3897.5 4211.8 3763.6 3765.9 3776.3 3788.7 3821.7 5137.5 5253.5 5265.2 5274.8 5340.0 4891.6 4905.0 4935.8 4943.6 4945.2 5228.4 5696.7 5718.4 5746.3 5775.0 3911.5 4135.6 4173.4 4185.9 4198.2 5484.5 5509.3 5764.9 5955.9 6042.5 3385.7 3763.8 4256.3 4258.2 4269.5 3844.5 4038.8 4129.9 4283.8 4337.6 3807.6 4542.0 4831.3 4871.2 4892.7 5046.4 5709.8 5739.3 5775.6 5777.5 1113.7 1133.4 1192.9 1333.2 1362.3 887.5 968.8 995.5 1004.0 1008.3 4219.1 5037.2 5064.4 5071.5 5091.8 4555.0 4675.3 5394.6 5566.6 5588.9 4533.8 4783.0 4794.7 4821.2 5040.5 2421.8 2624.6 2712.7 2786.8 2905.6 5100.9 5352.4 5780.3 5789.3 5836.0 5171.1 5264.5 5630.9 5690.6 5693.4 4548.0 5177.5 5446.0 5728.5 5741.8 4936.0 5039.6 5114.3 5533.9 5554.8 4786.6 5027.6 5043.7 5483.8 5491.5 5319.8 5731.8 5731.9 5762.5 5824.9 4028.2 4032.1 4051.0 4055.7 4069.2 4357.3 5421.5 5549.5 5840.7 5900.6 4116.4 4750.6 5096.7 5448.5 5549.0 4727.5 5047.6 5402.0 5613.7 5710.6 4637.6 5240.3 5566.4 5571.8 5597.7 5689.5 5697.5 5716.8 5744.4 5745.6 4672.5 4760.9 5347.3 5658.8 5679.6 20:28:50 INFO - PROCESS | 1988 | 20:28:50 INFO - PROCESS | 1988 | [#5] yui.html Cycles:180 Average:20546.69 Median:4214.00 stddev:29159.19 (692.0%) stddev-sans-first:29203.04 20:28:50 INFO - PROCESS | 1988 | Values: 735.7 742.3 746.9 865.8 887.6 13994.1 14696.9 14709.2 14718.9 14742.0 14462.3 14539.1 14632.6 14670.0 14677.3 724.2 743.1 896.9 906.6 908.2 734.4 879.9 887.7 895.3 915.0 962.4 963.0 964.3 966.2 966.7 918.7 955.8 958.6 961.0 963.2 690.4 691.7 718.1 719.6 722.0 15158.5 15527.8 15571.4 15844.4 16099.3 14256.6 14411.0 14847.9 14974.1 15357.3 11625.7 11638.9 11781.4 11857.4 12061.9 3837.2 3837.9 3880.0 3927.4 4072.5 100224.5 103989.0 105091.5 107813.0 108455.9 10564.0 10951.0 11108.8 11571.3 11929.8 22877.4 23235.2 23260.0 23267.8 23297.2 7403.3 7572.2 7683.1 7744.7 7801.5 4355.5 4407.8 4507.9 4513.1 4653.3 3631.2 3667.8 3727.7 3731.4 3759.0 676.7 685.5 692.7 704.5 704.9 652.7 653.7 661.3 670.6 678.5 9833.6 10206.4 10223.6 10347.5 10453.4 654.1 675.5 681.3 701.4 703.4 4902.8 4912.4 4930.0 4945.3 4946.8 80888.6 103384.5 103584.0 105423.5 110385.0 70992.6 87827.0 88316.0 89141.6 92345.6 64630.7 77542.0 81795.2 82692.0 84822.0 9628.5 9677.6 9698.3 9700.3 9718.5 49724.5 50195.7 50366.0 51205.7 51490.7 63948.7 70155.6 70889.0 72648.0 72837.6 11144.8 11625.7 11814.9 12411.1 13472.9 14616.4 14864.9 15843.7 16406.8 16422.3 13867.7 14539.7 14869.0 15022.0 15191.5 11415.7 13850.5 13854.7 14800.7 14982.5 13587.4 13983.7 14124.8 14496.9 14512.5 9613.1 10387.8 10395.0 10501.4 10555.3 8547.7 11282.5 11360.8 11651.5 12033.8 20:28:50 INFO - PROCESS | 1988 | -------- Summary: end -------- 20:28:50 INFO - PROCESS | 1988 | 20:28:51 INFO - TEST-INFO | 1988: exit 0 20:28:51 INFO - TEST-OK | dromaeo_css | took 1116810ms 20:28:51 INFO - TEST-START | kraken 20:28:51 INFO - operating with platform_type : mac_ 20:28:51 INFO - Initialising browser for kraken test... 20:28:51 INFO - TEST-INFO | started process 1992 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpsVPKvQ/profile http://localhost:53138/getInfo.html) 20:28:53 INFO - PROCESS | 1992 | __metrics Screen width/height:1600/1200 20:28:53 INFO - PROCESS | 1992 | colorDepth:24 20:28:53 INFO - PROCESS | 1992 | Browser inner width/height: 1024/689 20:28:53 INFO - PROCESS | 1992 | __metrics 20:28:53 INFO - PROCESS | 1992 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:28:53 INFO - PROCESS | 1992 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:28:54 INFO - TEST-INFO | 1992: exit 0 20:28:54 INFO - Browser initialized. 20:28:54 INFO - Running cycle 1/1 for kraken test... 20:28:54 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpsVPKvQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:29:05 INFO - PROCESS | 1994 | RSS: Main: 167522304 20:29:05 INFO - PROCESS | 1994 | 20:29:08 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53138/tests/kraken/driver.html?testName=audio-beat-detection) 20:29:09 INFO - PROCESS | 1994 | RSS: Main: 215580672 20:29:09 INFO - PROCESS | 1994 | 20:29:12 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53138/tests/kraken/driver.html?testName=audio-dft) 20:29:12 INFO - PROCESS | 1994 | RSS: Main: 229687296 20:29:12 INFO - PROCESS | 1994 | 20:29:15 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53138/tests/kraken/driver.html?testName=audio-fft) 20:29:16 INFO - PROCESS | 1994 | RSS: Main: 327606272 20:29:16 INFO - PROCESS | 1994 | 20:29:18 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53138/tests/kraken/driver.html?testName=audio-oscillator) 20:29:19 INFO - PROCESS | 1994 | RSS: Main: 230617088 20:29:19 INFO - PROCESS | 1994 | 20:29:21 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53138/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:29:21 INFO - PROCESS | 1994 | RSS: Main: 231116800 20:29:21 INFO - PROCESS | 1994 | 20:29:24 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53138/tests/kraken/driver.html?testName=imaging-darkroom) 20:29:25 INFO - PROCESS | 1994 | RSS: Main: 270450688 20:29:25 INFO - PROCESS | 1994 | 20:29:27 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53138/tests/kraken/driver.html?testName=imaging-desaturate) 20:29:28 INFO - PROCESS | 1994 | RSS: Main: 272531456 20:29:28 INFO - PROCESS | 1994 | 20:29:31 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53138/tests/kraken/driver.html?testName=json-parse-financial) 20:29:32 INFO - PROCESS | 1994 | RSS: Main: 267800576 20:29:32 INFO - PROCESS | 1994 | 20:29:33 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53138/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:29:34 INFO - PROCESS | 1994 | RSS: Main: 245526528 20:29:34 INFO - PROCESS | 1994 | 20:29:36 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53138/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:29:36 INFO - PROCESS | 1994 | RSS: Main: 250781696 20:29:36 INFO - PROCESS | 1994 | 20:29:38 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53138/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:29:39 INFO - PROCESS | 1994 | RSS: Main: 257196032 20:29:39 INFO - PROCESS | 1994 | 20:29:42 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:29:43 INFO - PROCESS | 1994 | RSS: Main: 272224256 20:29:43 INFO - PROCESS | 1994 | 20:29:45 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:29:46 INFO - PROCESS | 1994 | RSS: Main: 266301440 20:29:46 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | Cycle 1(1): loaded http://localhost:53138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53138/tests/kraken/driver.html?testName=ai-astar) 20:29:48 INFO - PROCESS | 1994 | RSS: Main: 310378496 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | __start_tp_report 20:29:48 INFO - PROCESS | 1994 | _x_x_mozilla_page_load 20:29:48 INFO - PROCESS | 1994 | _x_x_mozilla_page_load_details 20:29:48 INFO - PROCESS | 1994 | |i|pagename|runs| 20:29:48 INFO - PROCESS | 1994 | |0;ai-astar;112;115;115;114;113;113;113;114;114;114 20:29:48 INFO - PROCESS | 1994 | |1;audio-beat-detection;144;113;91;162;140;139;95;137;158;138 20:29:48 INFO - PROCESS | 1994 | |2;audio-dft;182;185;180;182;185;182;183;181;186;183 20:29:48 INFO - PROCESS | 1994 | |3;audio-fft;81;57;58;90;60;59;57;57;73;58 20:29:48 INFO - PROCESS | 1994 | |4;audio-oscillator;86;67;85;69;68;68;82;66;69;80 20:29:48 INFO - PROCESS | 1994 | |5;imaging-gaussian-blur;88;85;89;86;88;85;89;86;89;126 20:29:48 INFO - PROCESS | 1994 | |6;imaging-darkroom;93;93;95;94;94;93;94;93;94;93 20:29:48 INFO - PROCESS | 1994 | |7;imaging-desaturate;86;84;85;85;89;86;86;86;84;84 20:29:48 INFO - PROCESS | 1994 | |8;json-parse-financial;54;54;54;51;54;56;55;56;56;56 20:29:48 INFO - PROCESS | 1994 | |9;json-stringify-tinderbox;64;74;72;75;71;68;68;69;68;71 20:29:48 INFO - PROCESS | 1994 | |10;stanford-crypto-aes;82;80;84;81;84;80;83;82;86;82 20:29:48 INFO - PROCESS | 1994 | |11;stanford-crypto-ccm;134;133;135;147;123;123;146;157;180;145 20:29:48 INFO - PROCESS | 1994 | |12;stanford-crypto-pbkdf2;165;162;166;164;165;163;166;162;163;167 20:29:48 INFO - PROCESS | 1994 | |13;stanford-crypto-sha256-iterative;64;64;65;64;64;65;62;62;64;62 20:29:48 INFO - PROCESS | 1994 | __end_tp_report 20:29:48 INFO - PROCESS | 1994 | __start_cc_report 20:29:48 INFO - PROCESS | 1994 | _x_x_mozilla_cycle_collect,1963 20:29:48 INFO - PROCESS | 1994 | __end_cc_report 20:29:48 INFO - PROCESS | 1994 | __startTimestamp1490930988387__endTimestamp 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | ------- Summary: start ------- 20:29:48 INFO - PROCESS | 1994 | Number of tests: 14 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:0.95 (0.8%) stddev-sans-first:0.78 20:29:48 INFO - PROCESS | 1994 | Values: 112.0 115.0 115.0 114.0 113.0 113.0 113.0 114.0 114.0 114.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:151.00 stddev:24.28 (16.1%) stddev-sans-first:25.34 20:29:48 INFO - PROCESS | 1994 | Values: 144.0 113.0 91.0 162.0 140.0 139.0 95.0 137.0 158.0 138.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.00 stddev:1.91 (1.0%) stddev-sans-first:2.00 20:29:48 INFO - PROCESS | 1994 | Values: 182.0 185.0 180.0 182.0 185.0 182.0 183.0 181.0 186.0 183.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#3] audio-fft Cycles:10 Average:65.00 Median:59.50 stddev:12.00 (20.2%) stddev-sans-first:11.24 20:29:48 INFO - PROCESS | 1994 | Values: 81.0 57.0 58.0 90.0 60.0 59.0 57.0 57.0 73.0 58.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#4] audio-oscillator Cycles:10 Average:74.00 Median:74.50 stddev:8.16 (11.0%) stddev-sans-first:7.42 20:29:48 INFO - PROCESS | 1994 | Values: 86.0 67.0 85.0 69.0 68.0 68.0 82.0 66.0 69.0 80.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#5] imaging-gaussian-blur Cycles:10 Average:91.10 Median:88.00 stddev:12.37 (14.1%) stddev-sans-first:13.07 20:29:48 INFO - PROCESS | 1994 | Values: 88.0 85.0 89.0 86.0 88.0 85.0 89.0 86.0 89.0 126.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 20:29:48 INFO - PROCESS | 1994 | Values: 93.0 93.0 95.0 94.0 94.0 93.0 94.0 93.0 94.0 93.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.51 (1.8%) stddev-sans-first:1.59 20:29:48 INFO - PROCESS | 1994 | Values: 86.0 84.0 85.0 85.0 89.0 86.0 86.0 86.0 84.0 84.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.50 stddev:1.58 (2.8%) stddev-sans-first:1.66 20:29:48 INFO - PROCESS | 1994 | Values: 54.0 54.0 54.0 51.0 54.0 56.0 55.0 56.0 56.0 56.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:71.00 stddev:3.27 (4.6%) stddev-sans-first:2.65 20:29:48 INFO - PROCESS | 1994 | Values: 64.0 74.0 72.0 75.0 71.0 68.0 68.0 69.0 68.0 71.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.90 (2.3%) stddev-sans-first:2.01 20:29:48 INFO - PROCESS | 1994 | Values: 82.0 80.0 84.0 81.0 84.0 80.0 83.0 82.0 86.0 82.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:145.50 stddev:17.11 (11.8%) stddev-sans-first:17.88 20:29:48 INFO - PROCESS | 1994 | Values: 134.0 133.0 135.0 147.0 123.0 123.0 146.0 157.0 180.0 145.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:165.00 stddev:1.77 (1.1%) stddev-sans-first:1.86 20:29:48 INFO - PROCESS | 1994 | Values: 165.0 162.0 166.0 164.0 165.0 163.0 166.0 162.0 163.0 167.0 20:29:48 INFO - PROCESS | 1994 | 20:29:48 INFO - PROCESS | 1994 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.17 (1.8%) stddev-sans-first:1.24 20:29:48 INFO - PROCESS | 1994 | Values: 64.0 64.0 65.0 64.0 64.0 65.0 62.0 62.0 64.0 62.0 20:29:48 INFO - PROCESS | 1994 | -------- Summary: end -------- 20:29:48 INFO - PROCESS | 1994 | 20:29:49 INFO - TEST-INFO | 1994: exit 0 20:29:49 INFO - TEST-OK | kraken | took 58106ms 20:29:49 INFO - SUITE-END | took 1174s 20:29:49 INFO - Completed test suite (00:19:35) 20:29:49 INFO - javascript benchmark 20:29:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3352.664733526647, 3371.089805752447, 3375.4430518964373, 3391.508231306459, 3436.1409647588102, 5750.166225897247, 5793.971030144843, 5798.652080875145, 5817.476427121558, 5820.534357251415, 5780.739866705998, 5825.359210486843, 5854.18041474194, 5855.23881895353, 5880.411958804118, 5234.330491449369, 5244.396894357141, 5262.315898933133, 5284.577233821305, 5293.68237905725, 4781.976090119544, 4988.152014157602, 5205.063088644042, 5212.4266330703595, 5319.840404787863, 5207.244949482323, 5233.293505376763, 5246.37043554772, 5272.051030814452, 5325.840224793243, 5286.814961476349, 5312.92030619541, 5316.680999140025, 5321.308229930123, 5343.866403339928, 5173.586113110942, 5221.973890130525, 5225.294585230983, 5257.842264732064, 5299.152135658276, 5670.5463562914865, 5707.571932105108, 5730.856728581777, 5739.885202295931, 5785.623934444247, 6291.182146320994, 6318.71565779541, 6332.461740752042, 6334.049892516114, 6352.523560732963, 6239.906401403982, 6280.685965701697, 6283.968580157116, 6296.118543403927, 6297.590656607352, 5723.484886360206, 5799.0, 5821.941780582225, 5929.347771745104, 5929.673867937262, 6247.843803904939, 6305.590136641195, 6316.399942005502, 6378.330275321117, 6403.551751377358, 6199.776116419436, 6242.75028998844, 6253.218347706536, 6263.279722831932, 6267.1539342189135, 6227.252729672468, 6307.9369206308265, 6312.084747711556, 6313.936860631335, 6316.463100636497, 5185.377754669464, 6143.726821076141, 6208.068789681584, 6227.532935029891, 6283.748650053946, 6323.272823625342, 6335.873282534323, 6353.809385718436, 6359.745610175633, 6370.203724534434, 4952.851414457572, 4953.628477864175, 4990.875228119254, 4997.775100120503, 5012.398512178489, 3662.560492740888, 4418.55814418562, 4433.046894917608, 4437.156940181355, 4526.502084770673, 5787.681677507693, 5792.362840087587, 5822.388649191858, 5845.152452894306, 5858.736356863951, 6301.464375528039, 6312.274088479791, 6322.936770632326, 6330.335314791972, 6347.5239357047485, 5671.801486947937, 5680.6591604503865, 5754.338251101093, 5766.94233057664, 5771.624844385102, 5435.483629055233, 5453.754581043862, 5477.178423236546, 5483.835484935458, 5535.723213839292, 6273.560850740496, 6289.779857705142, 6290.087937248982, 6311.463525600284, 6343.904841427382, 5179.741012949262, 6302.65335406557, 6320.810375688737, 6340.334264902119, 6347.460465860268, 6163.476104531165, 6272.372762723691, 6274.215723034621, 6274.341194174728, 6294.15028971083, 6271.96864015677, 6286.18279623646, 6303.149074874833, 6318.557700960889, 6339.904901426575, 6231.594946328655, 6282.465990390868, 6287.874242515032, 6301.936980630135, 6307.779227727007, 4991.376077990251, 6068.6358818471035, 6136.2636483622255, 6170.0, 6238.438540531374, 5964.4035596441745, 6208.81373558794, 6213.751449941951, 6216.968915155395, 6227.96886015567, 6091.390860913873, 6095.786647467317, 6106.969465152646, 6113.786017489367, 6136.018237082224, 6064.241969753781, 6126.693665316628, 6183.598066125687, 6231.9688401557705, 6241.063840423973, 6025.337212906665, 6036.879262414815, 6036.879262414815, 6116.229271450518, 6145.539084568586], "value": 5741.568158171291, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.1879379529256, 461.91685496610614, 510.26012282190834, 518.1217835768373, 527.0302643136628, 32719.1820204495, 41708.37437438441, 44089.559104408945, 44122.896927576825, 46286.0, 45332.77333613327, 45816.08367832642, 45820.541794582045, 45901.540984590145, 45966.62100136993, 8756.737297881074, 9424.623015079424, 9640.469774162435, 9818.656347027856, 9822.361546499491, 8898.065703101178, 9139.634414623408, 9147.634094636207, 9217.631294748202, 9228.815423691522, 11786.705332366717, 12087.335196564185, 12110.576129835457, 12241.571544995926, 12250.387480625977, 11920.940395298012, 12027.27836329823, 12040.81938770919, 12049.93975030128, 12073.698157546043, 11751.294922304603, 11835.230710003822, 11838.171328007043, 11839.822402663967, 11875.34685592292, 42112.78943605293, 42341.57658423407, 42440.7267781964, 42467.36298955518, 42587.36118958218, 3478.7043101336417, 4034.7579145251084, 4086.7956602169775, 4144.378343248507, 4151.982764222755, 30752.53871191934, 31287.84356078205, 32597.27864641905, 32779.0, 32814.0, 3262.673732626742, 3289.555909952174, 3403.2002479417315, 3410.5225268462436, 3519.9120021999397, 348547.0, 430533.99999999686, 430636.0, 430802.0, 432738.0, 67886.0, 68006.31993679999, 68037.65981170062, 68461.65769171123, 68636.6568167156, 71211.0, 71245.93131103038, 71259.0, 71424.0, 71504.0, 17632.0, 17637.647247055243, 17984.2806287747, 18395.356162534248, 18417.355392561196, 13912.791308130387, 14011.649708757363, 14019.0, 14020.789688154686, 14022.088564243291, 16234.188290585424, 16582.08798516069, 17794.02132882678, 18646.81353186478, 18685.81314186868, 6061.424164704346, 6108.633481991094, 7146.428285737128, 7170.458351454462, 7249.238829922888, 875.3391189651772, 879.4283715584921, 902.4675441489553, 913.3287034029983, 940.3934462271797, 25514.362140946625, 30162.24594385114, 30329.0, 31013.534796978063, 32210.83894580512, 912.5528491039342, 954.2938225712923, 1064.2018486135398, 1073.7959787640323, 1145.4158379226487, 11862.0, 13719.931400343134, 14336.139831610137, 14980.92509537467, 15905.602359940862, 640095.0, 642281.0, 643943.0, 644175.0, 645242.0, 58236.0, 58458.123128153115, 58475.83048339094, 58482.0, 58738.70630646819, 1346.367207412534, 1391.6242614494233, 1433.1257932661276, 1472.2565104622097, 1483.3028476615973, 23747.406314841577, 24075.518489629758, 29546.704532954394, 30379.2405189872, 31072.0, 49304.26043609277, 49984.0, 50001.74995624993, 50140.997180056926, 50236.748816255684, 530428.0, 531873.0, 533505.0, 533562.0, 534245.3287733536, 23684.0, 24113.914873831072, 26106.73893261043, 26556.33609159709, 26562.0, 46152.7692361536, 46184.0, 46362.76818615885, 48181.27728084011, 48474.27208773105, 30429.86990910615, 31413.685863141076, 32261.35477290488, 32977.67022329842, 33075.0, 31945.520817188226, 32401.189970250933, 32943.67056329502, 33052.33895322128, 33071.66928330782, 35485.82257088801, 37591.24817503689, 38360.61639383682, 38384.808075959445, 38654.80672596619, 25369.365765856, 31946.84026579852, 31959.721611135294, 33077.338453231285, 33176.004719857476, 23599.46008098799, 25025.0, 25265.494690105726, 25364.492710146063, 25733.613995789703], "value": 20142.38094001722, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.6487849953797, 389.7408223531352, 394.1427395414972, 400.14145436401236, 425.156065210557, 15767.448139315125, 21224.4693882653, 21999.68001919886, 22798.544029119428, 22822.65766013509, 22766.975486103125, 22771.544569108606, 22972.0, 23758.40603984897, 23947.640785388234, 6013.579049466539, 6342.365763423667, 6343.460805831487, 6344.555881088326, 6345.270293916189, 6106.023036314191, 6137.539684523656, 6221.844453888666, 6251.531135164858, 6268.216472940882, 6098.512119030489, 6141.815745527641, 6232.626042437469, 6249.3438188990185, 6259.937400625981, 5962.195103661015, 6177.938220617803, 6254.530910181732, 6257.499400047986, 6262.12330273762, 5273.314469119028, 5363.973180134074, 5383.353997520284, 5494.780208791643, 5505.614606977513, 27382.630868456497, 28423.57364639532, 28455.430891382057, 28497.287567810763, 28757.281067973257, 2841.9395937945033, 2854.7631753504975, 2902.201894479014, 2908.6945870683485, 2915.318819583643, 15367.385304587802, 15614.687706245924, 15617.687646247012, 15708.764368534481, 16121.193940302937, 1832.8900265984084, 1892.4417296897448, 1893.2048539613395, 1893.640208360421, 1914.8851068935908, 129783.0, 136604.31697841547, 137745.311273443, 138207.30896345555, 139246.0, 9762.0, 11798.46906889192, 11886.702832429259, 12095.75808483843, 12241.143119981516, 13991.16053036821, 14734.63163420923, 15595.61010974712, 15646.061236325857, 15661.216939152997, 8802.295816334678, 8971.878515185601, 9124.726258212264, 9449.669261575811, 9636.518174091267, 9492.382995105434, 9499.0, 9503.57233924475, 9505.0, 9721.222302215805, 6440.871182576322, 6821.3519715626935, 6916.20463646687, 7227.960271990163, 7660.578668173192, 1676.7568702538063, 1798.3890651696363, 1830.401972578754, 1964.2143142743016, 1980.0, 1079.1259080145107, 1096.2600244834705, 1099.6206308823444, 1112.7885701716648, 1149.9482523286472, 18729.344472943383, 22406.84943766584, 23073.653895191586, 23630.0, 23722.288331350086, 693.0747452151334, 1097.665212110314, 1104.6575561575937, 1133.7505748735266, 1148.362658724416, 6476.89892718239, 7049.118860142482, 7499.512531685423, 7507.0, 7530.795072788327, 764284.0, 766658.0, 772879.0, 773265.0, 801275.0, 157866.0, 159011.0, 161648.06044485274, 162189.0, 165127.1743641298, 948.3266880514774, 1054.778496515725, 1075.7687097274124, 1099.373357186396, 1104.2889705772309, 12903.612891613267, 13104.737905242033, 13290.86709132935, 13353.599392018255, 13495.0, 43441.0, 55147.17279240895, 55423.44576554344, 57613.0, 57887.710561446926, 86343.13656863602, 87043.0, 88698.0, 88843.0, 90449.54775226081, 7814.843703126019, 8660.610272537877, 8891.0, 8996.695479155616, 9155.13026262504, 8494.532800695773, 8948.865767013369, 9593.0, 12921.547745828851, 13482.662933426744, 8141.8778718320455, 8155.735860941563, 8162.0, 8172.959135204286, 8195.344372450309, 6165.475934545614, 7454.701811927463, 7706.884396733942, 8003.879941800761, 8171.223733745284, 6913.274106218774, 7249.311315425026, 8525.658973641233, 8656.26421754158, 8657.610407531802, 11475.770484590428, 12970.610881673565, 13484.739543302245, 13799.102188540519, 13859.584212473643, 12224.75550489003, 12304.692382690504, 12310.322932238812, 12319.87680123223, 12418.875811241773], "value": 10036.182275764279, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.8317743459502, 1486.0415032304163, 1489.568025272671, 1511.5314252581697, 1516.052467207995, 7549.886751698715, 7882.251186137322, 8158.224968627986, 8618.396712230146, 8619.224269815715, 7762.534247945127, 7850.411219158572, 7853.136155022943, 7857.567833769141, 8129.6748130074875, 2327.359976006599, 2386.6658667786523, 2393.7366889642126, 2394.030417680842, 2394.1381102802975, 2299.41364951937, 2401.3156250468533, 2410.3371572817528, 2413.1553956115395, 2419.6733440985417, 1970.5861769028522, 2197.3188311623367, 2286.5312610914807, 2364.680768096302, 2398.2925037114005, 2369.052379048386, 2385.022140922222, 2390.8685022323766, 2391.0196819304, 2395.149721848736, 2350.7061617297836, 2355.658429527726, 2372.2764556810166, 2379.976200237993, 2412.2522018174423, 8575.099614540508, 8635.870461943075, 8637.611307491115, 8646.43798153118, 8656.523891185981, 4344.283193273106, 4801.7995501124715, 5167.741612919339, 5386.8383948481605, 5391.029614669358, 3063.433264846011, 3426.2119712466274, 3644.653757892996, 3695.1685870679153, 3715.3312403767313, 1191.7020744813797, 1232.3283810323396, 1238.2384833327528, 1310.6264714556305, 1314.434793038993, 10956.178286628534, 11071.114310855111, 11084.556617735361, 11088.55645774176, 11123.72190695231, 4604.217283061887, 4623.537646235417, 4745.145873742759, 4847.224444088929, 4853.077915196172, 9744.0, 9750.707478775648, 9753.414795112316, 9757.268204884662, 9776.657816976372, 5393.541548968303, 5451.64564303319, 5453.045716999509, 5455.781768729285, 5466.644668096561, 4880.194767863263, 4904.141775189399, 4973.577245934064, 4983.476734942851, 4991.376077990251, 3853.7109716771356, 3887.922241555153, 3971.841126354971, 4003.679705623543, 4010.0977280111742, 1271.4087949103712, 1277.7061275906594, 1285.1453783234044, 1297.5264028629672, 1310.1549500572078, 928.2852203803034, 937.6811883959487, 949.8765160529225, 962.1869520255373, 1010.3533738407425, 5683.374828768832, 5714.685692286964, 5764.164196191613, 5772.307323121252, 5889.3402940677515, 573.1345668041205, 581.3953488372131, 583.3990989281048, 587.8030859661976, 590.9497692696083, 3854.9807250963568, 3867.8646247381207, 3897.4738410314812, 3907.866718651559, 3921.3333733265413, 9567.665131720356, 10152.492375381202, 10169.54237059334, 10174.796504069876, 10190.235732320105, 9863.01369863008, 10116.24128190374, 10126.038026387481, 10127.291089623803, 10138.391696498235, 7674.654640541189, 7882.330001949898, 7914.327282180964, 7993.320567751806, 8033.5179889205665, 5409.134538473825, 5995.88008239824, 6010.729517171825, 6115.571909966259, 6125.816225513242, 7775.961120194363, 9079.500627465553, 9435.669751558662, 9498.762530936781, 9631.0, 9629.133377996013, 9661.758456038655, 9666.468344240853, 9752.024797520191, 9824.887649155466, 7357.742479013209, 7470.8879366810625, 7490.812729681802, 7603.543787372775, 7871.134175240833, 8039.437239393186, 8133.146019668086, 8181.509109453452, 8266.13205613426, 8275.95862020686, 7023.403010744144, 7067.540609860343, 7099.006139140628, 7115.466340024623, 7153.248908864703, 5891.646501209942, 6838.350356716104, 6942.548734332252, 6989.895151572832, 7059.152901651834, 6420.293767685457, 6555.70499327541, 6627.37039981201, 6644.136262285871, 6647.567908085959, 5119.6416250862085, 5160.432352441153, 5184.844454666366, 5227.843164705065, 5253.816116435906, 5105.463926287686, 5157.226416037624, 5237.554807841376, 5299.364076310867, 5387.191921211693], "value": 4470.310392663556, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.38964734070424, 369.6488336080722, 374.6590602551678, 385.8283064036501, 388.65021480667394, 4425.623821975136, 4475.955240447594, 5314.5748340132795, 5316.574674026078, 5472.315960504937, 4648.885246884587, 5153.959164093184, 5255.842324730254, 5260.8158714445, 5262.500312351631, 3489.633588473212, 4139.19285739281, 4164.479440069991, 4200.264953633117, 4215.831366745327, 3651.6713495785375, 4176.14389050244, 4195.433616461769, 4212.757236615206, 4218.662506999448, 3991.800409979504, 4184.811683474236, 4203.7057405981595, 4212.347086201628, 4232.174725928445, 3656.012876523337, 3855.7108216883566, 3884.3202439573242, 3897.4933258676474, 4211.789410529476, 3763.6424539668687, 3765.924681506382, 3776.282506323817, 3788.7158463115375, 3821.6560509553997, 5137.537621614036, 5253.474652534716, 5265.157194981764, 5274.784590472011, 5339.9733001335135, 4891.608671306287, 4905.007945153454, 4935.827246046407, 4943.629227807893, 4945.159322915113, 5228.398734145584, 5696.6866822324755, 5718.399568045337, 5746.281714785652, 5774.97112514439, 3911.5306163260307, 4135.627793498599, 4173.39485774564, 4185.91628167438, 4198.160367926427, 5484.451554844563, 5509.256250406224, 5764.942350576483, 5955.880882382371, 6042.546808989343, 3385.7122144617983, 3763.7553559018575, 4256.29771087767, 4258.212230737324, 4269.530351661315, 3844.519435070616, 4038.84892805549, 4129.855455059059, 4283.764392958417, 4337.587929146726, 3807.600201978808, 4541.9545804542195, 4831.347768051268, 4871.196252618278, 4892.730899800474, 5046.394432668103, 5709.8287051388525, 5739.253896993364, 5775.5668324875805, 5777.508911742465, 1113.7215696075982, 1133.3992983718642, 1192.9463174157183, 1333.240053169684, 1362.344751127385, 887.4719541872576, 968.7674958010027, 995.4823491784232, 1003.9899601004042, 1008.2841182760176, 4219.092895027584, 5037.168867136881, 5064.404712515546, 5071.54356107952, 5091.770870310845, 4554.977225113853, 4675.322078298627, 5394.595405344615, 5566.582506312043, 5588.944110558924, 4533.750643714628, 4783.010618363523, 4794.736289504111, 4821.192052980133, 5040.538243909298, 2421.8425802322795, 2624.6325514427995, 2712.6707913122427, 2786.801675279609, 2905.6198305804573, 5100.948990510122, 5352.357717073898, 5780.277465316835, 5789.334226563999, 5836.007878660638, 5171.146760784503, 5264.473552644705, 5630.8613169320515, 5690.577355661085, 5693.373728889819, 4547.954520454753, 5177.524405544402, 5445.957765837811, 5728.455796699307, 5741.799037033684, 4935.950640493549, 5039.571636410946, 5114.33513643224, 5533.889322213614, 5554.777948851246, 4786.58277569825, 5027.572656324107, 5043.722595257296, 5483.8080667176455, 5491.533219676372, 5319.813806516753, 5731.799387021434, 5731.942680573307, 5762.530554708523, 5824.883502329845, 4028.1943611277275, 4032.0524676700365, 4051.0480037190646, 4055.7363771354767, 4069.2471892699946, 4357.324614684729, 5421.539169170507, 5549.472800083986, 5840.678762668094, 5900.64596124234, 4116.403121547419, 4750.572448479654, 5096.668716533562, 5448.509634132947, 5548.9722551386985, 4727.479977202436, 5047.646664733434, 5402.027635025733, 5613.691246981455, 5710.600257982068, 4637.585536411427, 5240.292560504283, 5566.385748132996, 5571.804986825442, 5597.748101335368, 5689.516391106802, 5697.4587414195585, 5716.828495145152, 5744.443722543428, 5745.597808153389, 4672.5327467253, 4760.88097797544, 5347.304850369427, 5658.755073883739, 5679.551714312824], "value": 4113.099344920242, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.7125031195404, 742.3281929853481, 746.8655641984448, 865.7532603208085, 887.5739644970414, 13994.090384125026, 14696.85303146971, 14709.190994495326, 14718.852811471883, 14741.968062235648, 14462.349194286257, 14539.127652340867, 14632.561023169323, 14670.0, 14677.26613669315, 724.1961422820665, 743.1305372713911, 896.8520194167954, 906.5965645287849, 908.2189317187214, 734.3501001613557, 879.9076097009818, 887.7248053103526, 895.2703546609525, 915.0300681277834, 962.4033099478333, 963.0177219236409, 964.3056998960737, 966.21253678252, 966.6616684160558, 918.7427520294328, 955.7801705607679, 958.5542722634009, 960.9519524023771, 963.1572374172564, 690.4062506244626, 691.6541729135432, 718.1059580821858, 719.6186021408662, 721.9639816862766, 15158.545243642599, 15527.844721552752, 15571.37714491419, 15844.44544440939, 16099.275532601061, 14256.643583910381, 14411.0, 14847.851521484756, 14974.101553906801, 15357.308921098578, 11625.6512304631, 11638.941805291004, 11781.352025638587, 11857.407129643483, 12061.935637853563, 3837.213371258885, 3837.9424308635394, 3879.9806000970098, 3927.3716205407, 4072.5316588592395, 100224.49887750515, 103989.0, 105091.47454262679, 107813.0, 108455.91544084538, 10563.961759234322, 10951.0, 11108.833367499494, 11571.270849526847, 11929.821052684216, 22877.428064298525, 23235.186768463023, 23260.0, 23267.767322326898, 23297.18459853897, 7403.296686814744, 7572.242775722384, 7683.116441609286, 7744.728934487379, 7801.531908085533, 4355.477342718894, 4407.765825568846, 4507.932381014288, 4513.097380523843, 4653.302004699322, 3631.2374401375478, 3667.8349474273723, 3727.7390582658954, 3731.384321586962, 3759.0, 676.6853413162903, 685.4824607421365, 692.7021380806302, 704.475166001322, 704.9295070493013, 652.7062821730241, 653.6534738438831, 661.2990230355838, 670.6445583840572, 678.5080816408065, 9833.606655733834, 10206.4386458744, 10223.591056357662, 10347.482625868677, 10453.372797632166, 654.1430725749284, 675.5045174364514, 681.3186813186813, 701.4423533291045, 703.4442790195791, 4902.779374928136, 4912.38595175603, 4929.950700493021, 4945.2582112683385, 4946.826861059918, 80888.59555702301, 103384.48307758564, 103583.96416035894, 105423.47288263509, 110385.0, 70992.64503677448, 87827.0, 88316.0, 89141.55429222812, 92345.61235101176, 64630.67684661547, 77542.0, 81795.18204817876, 82692.0, 84822.0, 9628.47043412619, 9677.612895484102, 9698.321117521706, 9700.27247956392, 9718.514074296116, 49724.50826475211, 50195.74902125466, 50366.0, 51205.743971281394, 51490.74254628703, 63948.68025659842, 70155.64922175357, 70889.0, 72648.0, 72837.6358118206, 11144.777104457704, 11625.709357265798, 11814.881851181379, 12411.131220814455, 13472.86527134716, 14616.415343386145, 14864.851351486346, 15843.683126337179, 16406.753898691768, 16422.343106275614, 13867.653308667364, 14539.709205816036, 14869.033512821632, 15022.0, 15191.468298609496, 11415.714607134556, 13850.515231966832, 13854.65363365924, 14800.703985920436, 14982.475613353481, 13587.363004477345, 13983.720325593227, 14124.78812817788, 14496.85503144955, 14512.492062777752, 9613.14407817449, 10387.84418233712, 10395.0, 10501.422421766876, 10555.313904596176, 8547.74356769298, 11282.51784607385, 11360.772784544428, 11651.475683594428, 12033.819492707442], "value": 7655.316421839503, "unit": "score"}], "name": "dromaeo_css", "value": 7393.86018443761, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 115.0, 115.0, 114.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 113.0, 91.0, 162.0, 140.0, 139.0, 95.0, 137.0, 158.0, 138.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 185.0, 180.0, 182.0, 185.0, 182.0, 183.0, 181.0, 186.0, 183.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 58.0, 90.0, 60.0, 59.0, 57.0, 57.0, 73.0, 58.0], "value": 65.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 67.0, 85.0, 69.0, 68.0, 68.0, 82.0, 66.0, 69.0, 80.0], "value": 74.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 86.0, 88.0, 85.0, 89.0, 86.0, 89.0, 126.0], "value": 91.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 95.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 85.0, 89.0, 86.0, 86.0, 86.0, 84.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 51.0, 54.0, 56.0, 55.0, 56.0, 56.0, 56.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 72.0, 75.0, 71.0, 68.0, 68.0, 69.0, 68.0, 71.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 84.0, 81.0, 84.0, 80.0, 83.0, 82.0, 86.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 135.0, 147.0, 123.0, 123.0, 146.0, 157.0, 180.0, 145.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 162.0, 166.0, 164.0, 165.0, 163.0, 166.0, 162.0, 163.0, 167.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 62.0, 62.0, 64.0, 62.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1414.6999999999998, "alertThreshold": 2.0}]} 20:29:49 INFO - Return code: 0 20:29:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:29:49 INFO - # TBPL SUCCESS # 20:29:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:29:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:29:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:29:49 INFO - 2017-03-30 20:29:49.721 screenresolution[1998:19424] starting screenresolution argv=screenresolution get 20:29:49 INFO - 2017-03-30 20:29:49.724 screenresolution[1998:19424] Display 0: 1600x1200x32@60 20:29:49 INFO - 2017-03-30 20:29:49.730 screenresolution[1999:19427] starting screenresolution argv=screenresolution list 20:29:49 INFO - Available Modes on Display 0 20:29:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:29:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:29:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:29:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:29:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:29:49 INFO - Intel Iris: 20:29:49 INFO - Chipset Model: Intel Iris 20:29:49 INFO - Type: GPU 20:29:49 INFO - Bus: Built-In 20:29:49 INFO - VRAM (Dynamic, Max): 1536 MB 20:29:49 INFO - Vendor: Intel (0x8086) 20:29:49 INFO - Device ID: 0x0a2e 20:29:49 INFO - Revision ID: 0x0009 20:29:49 INFO - Displays: 20:29:49 INFO - Display: 20:29:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:29:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:29:49 INFO - Display Serial Number: 1600x1200 60 20:29:49 INFO - Main Display: Yes 20:29:49 INFO - Mirror: Off 20:29:49 INFO - Online: Yes 20:29:49 INFO - Rotation: Supported 20:29:49 INFO - Return code: 0 20:29:49 INFO - Running post-action listener: _resource_record_post_action 20:29:49 INFO - [mozharness: 2017-03-31 03:29:49.964862Z] Finished run-tests step (success) 20:29:49 INFO - Running post-run listener: _resource_record_post_run 20:29:50 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 872448; Write bytes: 418057728; Read time: 11; Write time: 1331 20:29:50 INFO - TinderboxPrint: CPU usage
53.6% 20:29:50 INFO - TinderboxPrint: I/O read bytes / time
872,448 / 11 20:29:50 INFO - TinderboxPrint: I/O write bytes / time
418,057,728 / 1,331 20:29:50 INFO - TinderboxPrint: CPU idle
2,207.0 (46.3%) 20:29:50 INFO - TinderboxPrint: CPU system
955.8 (20.1%) 20:29:50 INFO - TinderboxPrint: CPU user
1,598.9 (33.6%) 20:29:50 INFO - TinderboxPrint: Swap in / out
122,585,088 / 0 20:29:50 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121225728; Write bytes: 113823744; Read time: 10988; Write time: 215 20:29:50 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 724992; Write bytes: 294096384; Read time: 8; Write time: 1080 20:29:50 INFO - Running post-run listener: _upload_blobber_files 20:29:50 INFO - Blob upload gear active. 20:29:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:29:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:29:50 INFO - (blobuploader) - INFO - Open directory for files ... 20:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:29:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:51 INFO - (blobuploader) - INFO - Done attempting. 20:29:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:29:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:29:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:52 INFO - (blobuploader) - INFO - Done attempting. 20:29:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:29:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:29:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:53 INFO - (blobuploader) - INFO - Done attempting. 20:29:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:29:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:29:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:29:55 INFO - (blobuploader) - INFO - Done attempting. 20:29:55 INFO - (blobuploader) - INFO - Iteration through files over. 20:29:55 INFO - Return code: 0 20:29:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:29:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:29:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b327e6baa2a2b8d6c444f60af12c75f9824f9d7efa204bf8e309ac750ae05470151c8112760ab90713d7125a4bc569c866bf1c29bcd8bc101c470b6a62c90ec6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3e6a2a08222bdb24de9a9cbc025eab9c6cb1faaa19b641b99a222c81e56745218e389444cf9964830b721ea700061c29f5e516ee207b79446974853c430f374", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fee09314334f9cf8ba2fe6351ac9b2c602bbca783672a825b2fa17942a815dd03aaf4f808d16bdba7a3ee246edb2b0b4e933b88a01574774072486701240b5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c6441426edb69a46cd9fc0c93c1e4944bc23f4fc9616f6072f21dadba16c6879dff7da661e02788b97feccf4b486826623b4f6eef8846253da45515b8147bd2"} 20:29:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:29:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:29:55 INFO - Contents: 20:29:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b327e6baa2a2b8d6c444f60af12c75f9824f9d7efa204bf8e309ac750ae05470151c8112760ab90713d7125a4bc569c866bf1c29bcd8bc101c470b6a62c90ec6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3e6a2a08222bdb24de9a9cbc025eab9c6cb1faaa19b641b99a222c81e56745218e389444cf9964830b721ea700061c29f5e516ee207b79446974853c430f374", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fee09314334f9cf8ba2fe6351ac9b2c602bbca783672a825b2fa17942a815dd03aaf4f808d16bdba7a3ee246edb2b0b4e933b88a01574774072486701240b5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c6441426edb69a46cd9fc0c93c1e4944bc23f4fc9616f6072f21dadba16c6879dff7da661e02788b97feccf4b486826623b4f6eef8846253da45515b8147bd2"} 20:29:55 INFO - Running post-run listener: copy_logs_to_upload_dir 20:29:55 INFO - Copying logs to upload dir... 20:29:55 INFO - mkdir: /builds/slave/test/build/upload/logs 20:29:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.153097 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-03-30 20:29:55.740877) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 20:29:55.744463) ========= 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.FBst7QKjWE/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.3CNru181Ae/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b327e6baa2a2b8d6c444f60af12c75f9824f9d7efa204bf8e309ac750ae05470151c8112760ab90713d7125a4bc569c866bf1c29bcd8bc101c470b6a62c90ec6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3e6a2a08222bdb24de9a9cbc025eab9c6cb1faaa19b641b99a222c81e56745218e389444cf9964830b721ea700061c29f5e516ee207b79446974853c430f374", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fee09314334f9cf8ba2fe6351ac9b2c602bbca783672a825b2fa17942a815dd03aaf4f808d16bdba7a3ee246edb2b0b4e933b88a01574774072486701240b5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c6441426edb69a46cd9fc0c93c1e4944bc23f4fc9616f6072f21dadba16c6879dff7da661e02788b97feccf4b486826623b4f6eef8846253da45515b8147bd2"} build_url:https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010942 build_url: 'https://queue.taskcluster.net/v1/task/GiSEB9oaTUiJNkBULDebLQ/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b327e6baa2a2b8d6c444f60af12c75f9824f9d7efa204bf8e309ac750ae05470151c8112760ab90713d7125a4bc569c866bf1c29bcd8bc101c470b6a62c90ec6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e3e6a2a08222bdb24de9a9cbc025eab9c6cb1faaa19b641b99a222c81e56745218e389444cf9964830b721ea700061c29f5e516ee207b79446974853c430f374", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1fee09314334f9cf8ba2fe6351ac9b2c602bbca783672a825b2fa17942a815dd03aaf4f808d16bdba7a3ee246edb2b0b4e933b88a01574774072486701240b5b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c6441426edb69a46cd9fc0c93c1e4944bc23f4fc9616f6072f21dadba16c6879dff7da661e02788b97feccf4b486826623b4f6eef8846253da45515b8147bd2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-30 20:29:55.778240) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:29:55.778568) ========= 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.FBst7QKjWE/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.3CNru181Ae/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.005161 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-30 20:29:55.826786) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 20:29:55.827104) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-30 20:29:55.827401) ========= ========= Total master_lag: 0.18 =========