builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1478269111.11 results: success (0) buildid: 20161104043821 builduid: 61c53df9221e42e58d78fdf5626c24d6 revision: f29e3dc3f53e186ff2822be1d28f50b2e76853d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:31.113770) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:31.114288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:31.114588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:31.129813) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:31.130225) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-04 07:18:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-11-04 07:18:32 (103 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131603 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:31.275740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:31.276152) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017223 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:31.328110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:31.328791) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f29e3dc3f53e186ff2822be1d28f50b2e76853d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f29e3dc3f53e186ff2822be1d28f50b2e76853d2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-04 07:18:32,213 truncating revision to first 12 chars 2016-11-04 07:18:32,213 Setting DEBUG logging. 2016-11-04 07:18:32,213 attempt 1/10 2016-11-04 07:18:32,213 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f29e3dc3f53e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-04 07:18:32,708 unpacking tar archive at: mozilla-aurora-f29e3dc3f53e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.796492 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:32.139605) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:32.139906) ========= script_repo_revision: f29e3dc3f53e186ff2822be1d28f50b2e76853d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:32.143317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:32.143600) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-04 07:18:32.154441) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-04 07:18:32.154773) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:18:33 INFO - MultiFileLogger online at 20161104 07:18:33 in /builds/slave/test 07:18:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:18:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:18:33 INFO - {'append_to_log': False, 07:18:33 INFO - 'base_work_dir': '/builds/slave/test', 07:18:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:18:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:18:33 INFO - 'branch': 'Mozilla-Aurora', 07:18:33 INFO - 'buildbot_json_path': 'buildprops.json', 07:18:33 INFO - 'config_files': ('talos/linux_config.py',), 07:18:33 INFO - 'default_actions': ('clobber', 07:18:33 INFO - 'read-buildbot-config', 07:18:33 INFO - 'download-and-extract', 07:18:33 INFO - 'populate-webroot', 07:18:33 INFO - 'create-virtualenv', 07:18:33 INFO - 'install', 07:18:33 INFO - 'run-tests'), 07:18:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:18:33 INFO - 'download_minidump_stackwalk': True, 07:18:33 INFO - 'download_symbols': 'ondemand', 07:18:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:18:33 INFO - 'tooltool.py': '/tools/tooltool.py', 07:18:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:18:33 INFO - '/tools/misc-python/virtualenv.py')}, 07:18:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:18:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:18:33 INFO - 'installer_path': 'installer.exe', 07:18:33 INFO - 'log_level': 'info', 07:18:33 INFO - 'log_name': 'talos', 07:18:33 INFO - 'log_to_console': True, 07:18:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:18:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:18:33 INFO - 'opt_config_files': (), 07:18:33 INFO - 'pip_index': False, 07:18:33 INFO - 'sps_profile': False, 07:18:33 INFO - 'sps_profile_interval': 0, 07:18:33 INFO - 'suite': 'dromaeojs', 07:18:33 INFO - 'system_bits': '32', 07:18:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:18:33 INFO - 'title': 'talos-linux64-ix-034', 07:18:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:18:33 INFO - 'use_talos_json': True, 07:18:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:18:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:18:33 INFO - 'work_dir': 'build'} 07:18:33 INFO - [mozharness: 2016-11-04 14:18:33.131241Z] Running clobber step. 07:18:33 INFO - Running pre-action listener: _resource_record_pre_action 07:18:33 INFO - Running main action method: clobber 07:18:33 INFO - rmtree: /builds/slave/test/build 07:18:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:18:33 INFO - Running post-action listener: _resource_record_post_action 07:18:33 INFO - [mozharness: 2016-11-04 14:18:33.595994Z] Finished clobber step (success) 07:18:33 INFO - [mozharness: 2016-11-04 14:18:33.596097Z] Running read-buildbot-config step. 07:18:33 INFO - Running pre-action listener: _resource_record_pre_action 07:18:33 INFO - Running main action method: read_buildbot_config 07:18:33 INFO - Using buildbot properties: 07:18:33 INFO - { 07:18:33 INFO - "project": "", 07:18:33 INFO - "product": "firefox", 07:18:33 INFO - "script_repo_revision": "production", 07:18:33 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:18:33 INFO - "repository": "", 07:18:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:18:33 INFO - "buildid": "20161104043821", 07:18:33 INFO - "pgo_build": "True", 07:18:33 INFO - "basedir": "/builds/slave/test", 07:18:33 INFO - "buildnumber": 571, 07:18:33 INFO - "slavename": "talos-linux64-ix-034", 07:18:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:18:33 INFO - "platform": "ubuntu64_hw", 07:18:33 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:18:33 INFO - "branch": "mozilla-aurora", 07:18:33 INFO - "repo_path": "releases/mozilla-aurora", 07:18:33 INFO - "revision": "f29e3dc3f53e186ff2822be1d28f50b2e76853d2", 07:18:33 INFO - "stage_platform": "linux64-pgo", 07:18:33 INFO - "builduid": "61c53df9221e42e58d78fdf5626c24d6", 07:18:33 INFO - "slavebuilddir": "test" 07:18:33 INFO - } 07:18:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 07:18:33 INFO - Running post-action listener: _resource_record_post_action 07:18:33 INFO - [mozharness: 2016-11-04 14:18:33.598553Z] Finished read-buildbot-config step (success) 07:18:33 INFO - [mozharness: 2016-11-04 14:18:33.598643Z] Running download-and-extract step. 07:18:33 INFO - Running pre-action listener: _resource_record_pre_action 07:18:33 INFO - Running main action method: download_and_extract 07:18:33 INFO - mkdir: /builds/slave/test/build/tests 07:18:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:33 INFO - trying https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:18:33 INFO - Downloading https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:18:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:18:34 INFO - Downloaded 1361 bytes. 07:18:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 07:18:34 INFO - Using the following test package requirements: 07:18:34 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:18:34 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:34 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:18:34 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:34 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:18:34 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:34 INFO - u'jsshell-linux-x86_64.zip'], 07:18:34 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:34 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:18:34 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 07:18:34 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:34 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:18:34 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:34 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:18:34 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:34 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:18:34 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 07:18:34 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:18:34 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:18:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 07:18:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:18:34 INFO - Fetch https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:18:34 INFO - Expected file size: 21894816 07:18:39 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:18:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 07:18:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:18:39 INFO - Fetch https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:18:39 INFO - Expected file size: 21894816 07:18:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 07:18:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:18:44 INFO - Fetch https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 07:18:45 INFO - Expected file size: 14414089 07:18:45 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')]} 07:18:45 INFO - trying https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:18:45 INFO - Downloading https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:18:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:18:46 INFO - Downloaded 64020347 bytes. 07:18:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:18:46 INFO - mkdir: /builds/slave/test/properties 07:18:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:18:46 INFO - Writing to file /builds/slave/test/properties/build_url 07:18:46 INFO - Contents: 07:18:46 INFO - build_url:https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 07:18:47 INFO - Running post-action listener: _resource_record_post_action 07:18:47 INFO - Running post-action listener: set_extra_try_arguments 07:18:47 INFO - [mozharness: 2016-11-04 14:18:47.387942Z] Finished download-and-extract step (success) 07:18:47 INFO - [mozharness: 2016-11-04 14:18:47.388181Z] Running populate-webroot step. 07:18:47 INFO - Running pre-action listener: _resource_record_pre_action 07:18:47 INFO - Running main action method: populate_webroot 07:18:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:18:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:18:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:18:47 INFO - '--tppagecycles', 07:18:47 INFO - '7'], 07:18:47 INFO - 'tests': ['tsvgm']}}, 07:18:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:18:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:18:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:18:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:18:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:18:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['damp', 'tps']}, 07:18:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'tests': ['damp', 'tps']}, 07:18:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['dromaeo_dom']}, 07:18:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:18:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['basic_compositor_video']}, 07:18:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:18:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'other-e10s': {'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['a11yr', 07:18:47 INFO - 'ts_paint', 07:18:47 INFO - 'tpaint', 07:18:47 INFO - 'sessionrestore', 07:18:47 INFO - 'sessionrestore_no_auto_restore', 07:18:47 INFO - 'tabpaint']}, 07:18:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['tsvgx', 07:18:47 INFO - 'tsvgr_opacity', 07:18:47 INFO - 'tart', 07:18:47 INFO - 'tscrollx', 07:18:47 INFO - 'cart']}, 07:18:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:18:47 INFO - 'tsvgr_opacity', 07:18:47 INFO - 'tart', 07:18:47 INFO - 'tscrollx', 07:18:47 INFO - 'cart']}, 07:18:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'talos_options': ['--disable-e10s'], 07:18:47 INFO - 'tests': ['tp5o']}, 07:18:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'tests': ['tp5o']}, 07:18:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'talos_options': ['--disable-e10s', 07:18:47 INFO - '--xperf_path', 07:18:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:47 INFO - 'tests': ['tp5n']}, 07:18:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:18:47 INFO - 'talos_options': ['--xperf_path', 07:18:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:18:47 INFO - 'tests': ['tp5n']}}, 07:18:47 INFO - 'talos.zip': {'path': '', 07:18:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:18:47 INFO - Running post-action listener: _resource_record_post_action 07:18:47 INFO - [mozharness: 2016-11-04 14:18:47.406968Z] Finished populate-webroot step (success) 07:18:47 INFO - [mozharness: 2016-11-04 14:18:47.407057Z] Running create-virtualenv step. 07:18:47 INFO - Running pre-action listener: _resource_record_pre_action 07:18:47 INFO - Running main action method: create_virtualenv 07:18:47 INFO - Creating virtualenv /builds/slave/test/build/venv 07:18:47 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 07:18:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:18:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:18:47 INFO - Using real prefix '/usr' 07:18:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:18:48 INFO - Installing distribute.............................................................................................................................................................................................done. 07:18:49 INFO - Installing pip.................done. 07:18:50 INFO - Return code: 0 07:18:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 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 0x7f22a1fc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017f60>, '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 0x1018d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:50 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 07:18:50 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 07:18:50 INFO - Using env: {'DISPLAY': ':0', 07:18:50 INFO - 'HOME': '/home/cltbld', 07:18:50 INFO - 'LANG': 'en_US.UTF-8', 07:18:50 INFO - 'LANGUAGE': 'en_US:en', 07:18:50 INFO - 'LOGNAME': 'cltbld', 07:18:50 INFO - 'MAIL': '/var/mail/cltbld', 07:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:50 INFO - 'MOZ_NO_REMOTE': '1', 07:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:50 INFO - 'NO_EM_RESTART': '1', 07:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:50 INFO - 'PWD': '/builds/slave/test', 07:18:50 INFO - 'SHELL': '/bin/bash', 07:18:50 INFO - 'SHLVL': '1', 07:18:50 INFO - 'TERM': 'linux', 07:18:50 INFO - 'TMOUT': '86400', 07:18:50 INFO - 'USER': 'cltbld', 07:18:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 07:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:50 INFO - '_': '/tools/buildbot/bin/python'} 07:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:50 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 07:18:50 INFO - Cleaning up... 07:18:50 INFO - Return code: 0 07:18:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:50 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 0x7f22a1fc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017f60>, '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 0x1018d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:50 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 07:18:50 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 07:18:50 INFO - Using env: {'DISPLAY': ':0', 07:18:50 INFO - 'HOME': '/home/cltbld', 07:18:50 INFO - 'LANG': 'en_US.UTF-8', 07:18:50 INFO - 'LANGUAGE': 'en_US:en', 07:18:50 INFO - 'LOGNAME': 'cltbld', 07:18:50 INFO - 'MAIL': '/var/mail/cltbld', 07:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:50 INFO - 'MOZ_NO_REMOTE': '1', 07:18:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:50 INFO - 'NO_EM_RESTART': '1', 07:18:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:50 INFO - 'PWD': '/builds/slave/test', 07:18:50 INFO - 'SHELL': '/bin/bash', 07:18:50 INFO - 'SHLVL': '1', 07:18:50 INFO - 'TERM': 'linux', 07:18:50 INFO - 'TMOUT': '86400', 07:18:50 INFO - 'USER': 'cltbld', 07:18:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 07:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:50 INFO - '_': '/tools/buildbot/bin/python'} 07:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:50 INFO - Downloading/unpacking psutil>=3.1.1 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:18:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:52 INFO - Installing collected packages: psutil 07:18:52 INFO - Running setup.py install for psutil 07:18:52 INFO - building 'psutil._psutil_linux' extension 07:18:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:18:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:18:52 INFO - building 'psutil._psutil_posix' extension 07:18:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:18:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:18:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:18:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:18:52 INFO - Successfully installed psutil 07:18:52 INFO - Cleaning up... 07:18:53 INFO - Return code: 0 07:18:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:18:53 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')]} 07:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:53 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')]} 07:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:53 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 0x7f22a1fc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017f60>, '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 0x1018d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:53 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 07:18:53 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 07:18:53 INFO - Using env: {'DISPLAY': ':0', 07:18:53 INFO - 'HOME': '/home/cltbld', 07:18:53 INFO - 'LANG': 'en_US.UTF-8', 07:18:53 INFO - 'LANGUAGE': 'en_US:en', 07:18:53 INFO - 'LOGNAME': 'cltbld', 07:18:53 INFO - 'MAIL': '/var/mail/cltbld', 07:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:53 INFO - 'MOZ_NO_REMOTE': '1', 07:18:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:53 INFO - 'NO_EM_RESTART': '1', 07:18:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:53 INFO - 'PWD': '/builds/slave/test', 07:18:53 INFO - 'SHELL': '/bin/bash', 07:18:53 INFO - 'SHLVL': '1', 07:18:53 INFO - 'TERM': 'linux', 07:18:53 INFO - 'TMOUT': '86400', 07:18:53 INFO - 'USER': 'cltbld', 07:18:53 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 07:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:53 INFO - '_': '/tools/buildbot/bin/python'} 07:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:18: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 07:18: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 07:18: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 07:18: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 07:18: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 07:18: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 07:18:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:18:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:18:55 INFO - Installing collected packages: mozsystemmonitor 07:18:55 INFO - Running setup.py install for mozsystemmonitor 07:18:55 INFO - Successfully installed mozsystemmonitor 07:18:55 INFO - Cleaning up... 07:18:55 INFO - Return code: 0 07:18:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:18:55 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')]} 07:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 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')]} 07:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:55 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 0x7f22a1fc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017f60>, '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 0x1018d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:55 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 07:18:55 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 07:18:55 INFO - Using env: {'DISPLAY': ':0', 07:18:55 INFO - 'HOME': '/home/cltbld', 07:18:55 INFO - 'LANG': 'en_US.UTF-8', 07:18:55 INFO - 'LANGUAGE': 'en_US:en', 07:18:55 INFO - 'LOGNAME': 'cltbld', 07:18:55 INFO - 'MAIL': '/var/mail/cltbld', 07:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:55 INFO - 'MOZ_NO_REMOTE': '1', 07:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:55 INFO - 'NO_EM_RESTART': '1', 07:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:55 INFO - 'PWD': '/builds/slave/test', 07:18:55 INFO - 'SHELL': '/bin/bash', 07:18:55 INFO - 'SHLVL': '1', 07:18:55 INFO - 'TERM': 'linux', 07:18:55 INFO - 'TMOUT': '86400', 07:18:55 INFO - 'USER': 'cltbld', 07:18:55 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 07:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:55 INFO - '_': '/tools/buildbot/bin/python'} 07:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:55 INFO - Downloading/unpacking jsonschema==2.5.1 07:18:55 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 07:18:55 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 07:18:55 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 07:18:55 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 07:18:55 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 07:18:55 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 07:18:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:18:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:57 INFO - Downloading functools32-3.2.3-2.tar.gz 07:18:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:18:57 INFO - warning: no files found matching '*.txt' 07:18:57 INFO - no previously-included directories found matching 'build' 07:18:57 INFO - no previously-included directories found matching 'dist' 07:18:57 INFO - no previously-included directories found matching '.git*' 07:18:57 INFO - Installing collected packages: jsonschema, functools32 07:18:57 INFO - Running setup.py install for functools32 07:18:57 INFO - warning: no files found matching '*.txt' 07:18:57 INFO - no previously-included directories found matching 'build' 07:18:57 INFO - no previously-included directories found matching 'dist' 07:18:57 INFO - no previously-included directories found matching '.git*' 07:18:57 INFO - Successfully installed jsonschema functools32 07:18:57 INFO - Cleaning up... 07:18:57 INFO - Return code: 0 07:18:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:18: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')]} 07:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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')]} 07:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:57 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 0x7f22a1fc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017f60>, '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 0x1018d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18:57 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 07:18:57 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 07:18:57 INFO - Using env: {'DISPLAY': ':0', 07:18:57 INFO - 'HOME': '/home/cltbld', 07:18:57 INFO - 'LANG': 'en_US.UTF-8', 07:18:57 INFO - 'LANGUAGE': 'en_US:en', 07:18:57 INFO - 'LOGNAME': 'cltbld', 07:18:57 INFO - 'MAIL': '/var/mail/cltbld', 07:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:57 INFO - 'MOZ_NO_REMOTE': '1', 07:18:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:57 INFO - 'NO_EM_RESTART': '1', 07:18:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:57 INFO - 'PWD': '/builds/slave/test', 07:18:57 INFO - 'SHELL': '/bin/bash', 07:18:57 INFO - 'SHLVL': '1', 07:18:57 INFO - 'TERM': 'linux', 07:18:57 INFO - 'TMOUT': '86400', 07:18:57 INFO - 'USER': 'cltbld', 07:18:57 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 07:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:57 INFO - '_': '/tools/buildbot/bin/python'} 07:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:18:58 INFO - Cleaning up... 07:18:58 INFO - Return code: 0 07:18:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:18:58 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')]} 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18:58 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')]} 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:18:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:18: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', '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 0x7f22a1fc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017f60>, '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 0x1018d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:18: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:18: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 blobuploader==1.2.4 07:18:58 INFO - Using env: {'DISPLAY': ':0', 07:18:58 INFO - 'HOME': '/home/cltbld', 07:18:58 INFO - 'LANG': 'en_US.UTF-8', 07:18:58 INFO - 'LANGUAGE': 'en_US:en', 07:18:58 INFO - 'LOGNAME': 'cltbld', 07:18:58 INFO - 'MAIL': '/var/mail/cltbld', 07:18:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:58 INFO - 'MOZ_NO_REMOTE': '1', 07:18:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:58 INFO - 'NO_EM_RESTART': '1', 07:18:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:58 INFO - 'PWD': '/builds/slave/test', 07:18:58 INFO - 'SHELL': '/bin/bash', 07:18:58 INFO - 'SHLVL': '1', 07:18:58 INFO - 'TERM': 'linux', 07:18:58 INFO - 'TMOUT': '86400', 07:18:58 INFO - 'USER': 'cltbld', 07:18:58 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 07:18:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:58 INFO - '_': '/tools/buildbot/bin/python'} 07:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:18:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:18:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:18:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:18:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:19:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:19:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:19:01 INFO - Downloading docopt-0.6.1.tar.gz 07:19:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:19:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:19:01 INFO - Running setup.py install for blobuploader 07:19:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:19:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:19:01 INFO - Running setup.py install for requests 07:19:01 INFO - Running setup.py install for docopt 07:19:01 INFO - Successfully installed blobuploader requests docopt 07:19:01 INFO - Cleaning up... 07:19:01 INFO - Return code: 0 07:19:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:01 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 0x7f22a1fc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017f60>, '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 0x1018d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:01 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 07:19:01 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 07:19:01 INFO - Using env: {'DISPLAY': ':0', 07:19:01 INFO - 'HOME': '/home/cltbld', 07:19:01 INFO - 'LANG': 'en_US.UTF-8', 07:19:01 INFO - 'LANGUAGE': 'en_US:en', 07:19:01 INFO - 'LOGNAME': 'cltbld', 07:19:01 INFO - 'MAIL': '/var/mail/cltbld', 07:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:01 INFO - 'MOZ_NO_REMOTE': '1', 07:19:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:01 INFO - 'NO_EM_RESTART': '1', 07:19:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:01 INFO - 'PWD': '/builds/slave/test', 07:19:01 INFO - 'SHELL': '/bin/bash', 07:19:01 INFO - 'SHLVL': '1', 07:19:01 INFO - 'TERM': 'linux', 07:19:01 INFO - 'TMOUT': '86400', 07:19:01 INFO - 'USER': 'cltbld', 07:19:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 07:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:01 INFO - '_': '/tools/buildbot/bin/python'} 07:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:01 INFO - Running setup.py (path:/tmp/pip-rrPaDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:02 INFO - Running setup.py (path:/tmp/pip-h5_asd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:02 INFO - Running setup.py (path:/tmp/pip-Cy_wiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:02 INFO - Running setup.py (path:/tmp/pip-wx8XbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:02 INFO - Running setup.py (path:/tmp/pip-yHgqxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:02 INFO - Running setup.py (path:/tmp/pip-iwzouf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:02 INFO - Running setup.py (path:/tmp/pip-5bRcjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:02 INFO - Running setup.py (path:/tmp/pip-jSM9gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:02 INFO - Running setup.py (path:/tmp/pip-aamHfS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:02 INFO - Running setup.py (path:/tmp/pip-NlAkh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:02 INFO - Running setup.py (path:/tmp/pip-Rw1fQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:02 INFO - Running setup.py (path:/tmp/pip-QbwqQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:02 INFO - Running setup.py (path:/tmp/pip-KJ8htN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:02 INFO - Running setup.py (path:/tmp/pip-vqlDri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:02 INFO - Running setup.py (path:/tmp/pip-UXdzTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:03 INFO - Running setup.py (path:/tmp/pip-I4xnjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:03 INFO - Running setup.py (path:/tmp/pip-YHJZLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:19:03 INFO - Running setup.py install for manifestparser 07:19:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Running setup.py install for mozcrash 07:19:03 INFO - Running setup.py install for mozdebug 07:19:03 INFO - Running setup.py install for mozdevice 07:19:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Running setup.py install for mozfile 07:19:03 INFO - Running setup.py install for mozhttpd 07:19:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Running setup.py install for mozinfo 07:19:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Running setup.py install for mozInstall 07:19:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:19:03 INFO - Running setup.py install for mozleak 07:19:04 INFO - Running setup.py install for mozlog 07:19:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for moznetwork 07:19:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozprocess 07:19:04 INFO - Running setup.py install for mozprofile 07:19:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozrunner 07:19:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Running setup.py install for mozscreenshot 07:19:04 INFO - Running setup.py install for moztest 07:19:04 INFO - Running setup.py install for mozversion 07:19:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:19:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:19:04 INFO - Cleaning up... 07:19:04 INFO - Return code: 0 07:19:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19: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')]} 07:19:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19: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')]} 07:19:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:04 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 0x7f22a1fc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017f60>, '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 0x1018d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:04 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 07:19:04 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 07:19:04 INFO - Using env: {'DISPLAY': ':0', 07:19:04 INFO - 'HOME': '/home/cltbld', 07:19:04 INFO - 'LANG': 'en_US.UTF-8', 07:19:04 INFO - 'LANGUAGE': 'en_US:en', 07:19:04 INFO - 'LOGNAME': 'cltbld', 07:19:04 INFO - 'MAIL': '/var/mail/cltbld', 07:19:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:04 INFO - 'MOZ_NO_REMOTE': '1', 07:19:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:04 INFO - 'NO_EM_RESTART': '1', 07:19:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:04 INFO - 'PWD': '/builds/slave/test', 07:19:04 INFO - 'SHELL': '/bin/bash', 07:19:04 INFO - 'SHLVL': '1', 07:19:04 INFO - 'TERM': 'linux', 07:19:04 INFO - 'TMOUT': '86400', 07:19:04 INFO - 'USER': 'cltbld', 07:19:04 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 07:19:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:04 INFO - '_': '/tools/buildbot/bin/python'} 07:19:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:19:05 INFO - Running setup.py (path:/tmp/pip-DEabZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:19:05 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)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:19:05 INFO - Running setup.py (path:/tmp/pip-0STqNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:19:05 INFO - Running setup.py (path:/tmp/pip-n2spHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:19:05 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)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:19:05 INFO - Running setup.py (path:/tmp/pip-NqJnKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:19:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:19:05 INFO - Running setup.py (path:/tmp/pip-BlgEQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:19:05 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)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:19:05 INFO - Running setup.py (path:/tmp/pip-tmDojN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:19:05 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)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:19:05 INFO - Running setup.py (path:/tmp/pip-gva4rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:19:05 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)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:19:05 INFO - Running setup.py (path:/tmp/pip-dKY885-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:19:05 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)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:19:05 INFO - Running setup.py (path:/tmp/pip-in3UvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:19:05 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)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:19:05 INFO - Running setup.py (path:/tmp/pip-IKAxOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:19:05 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)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:19:05 INFO - Running setup.py (path:/tmp/pip-c3Vl3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:19:05 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)) 07:19:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:19:06 INFO - Running setup.py (path:/tmp/pip-AVtKtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:19:06 INFO - Running setup.py (path:/tmp/pip-gbWK4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:19:06 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)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:19:06 INFO - Running setup.py (path:/tmp/pip-57WcDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:06 INFO - Running setup.py (path:/tmp/pip-zZ3zR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:19:06 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)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:19:06 INFO - Running setup.py (path:/tmp/pip-nQjCT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 07:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:19:06 INFO - Running setup.py (path:/tmp/pip-LLKgSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:19:06 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)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:19:06 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)) 07:19:06 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:06 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:19:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:19:06 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 07:19:06 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 07:19:06 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 07:19:06 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 07:19:06 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 07:19:06 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 07:19:08 INFO - Downloading blessings-1.6.tar.gz 07:19:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:19:08 INFO - Installing collected packages: blessings 07:19:08 INFO - Running setup.py install for blessings 07:19:08 INFO - Successfully installed blessings 07:19:08 INFO - Cleaning up... 07:19:08 INFO - Return code: 0 07:19:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:19:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:08 INFO - Reading from file tmpfile_stdout 07:19:08 INFO - Current package versions: 07:19:08 INFO - argparse == 1.2.1 07:19:08 INFO - blessings == 1.6 07:19:08 INFO - blobuploader == 1.2.4 07:19:08 INFO - docopt == 0.6.1 07:19:08 INFO - functools32 == 3.2.3-2 07:19:08 INFO - jsonschema == 2.5.1 07:19:08 INFO - manifestparser == 1.1 07:19:08 INFO - mozInstall == 1.12 07:19:08 INFO - mozcrash == 0.17 07:19:08 INFO - mozdebug == 0.1 07:19:08 INFO - mozdevice == 0.48 07:19:08 INFO - mozfile == 1.2 07:19:08 INFO - mozhttpd == 0.7 07:19:08 INFO - mozinfo == 0.9 07:19:08 INFO - mozleak == 0.1 07:19:08 INFO - mozlog == 3.4 07:19:08 INFO - moznetwork == 0.27 07:19:08 INFO - mozprocess == 0.23 07:19:08 INFO - mozprofile == 0.28 07:19:08 INFO - mozrunner == 6.12 07:19:08 INFO - mozscreenshot == 0.1 07:19:08 INFO - mozsystemmonitor == 0.3 07:19:08 INFO - moztest == 0.7 07:19:08 INFO - mozversion == 1.4 07:19:08 INFO - psutil == 3.1.1 07:19:08 INFO - requests == 1.2.3 07:19:08 INFO - wsgiref == 0.1.2 07:19:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:08 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 0x7f22a1fc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017f60>, '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 0x1018d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:08 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 07:19:08 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 07:19:08 INFO - Using env: {'DISPLAY': ':0', 07:19:08 INFO - 'HOME': '/home/cltbld', 07:19:08 INFO - 'LANG': 'en_US.UTF-8', 07:19:08 INFO - 'LANGUAGE': 'en_US:en', 07:19:08 INFO - 'LOGNAME': 'cltbld', 07:19:08 INFO - 'MAIL': '/var/mail/cltbld', 07:19:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:08 INFO - 'MOZ_NO_REMOTE': '1', 07:19:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:08 INFO - 'NO_EM_RESTART': '1', 07:19:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:08 INFO - 'PWD': '/builds/slave/test', 07:19:08 INFO - 'SHELL': '/bin/bash', 07:19:08 INFO - 'SHLVL': '1', 07:19:08 INFO - 'TERM': 'linux', 07:19:08 INFO - 'TMOUT': '86400', 07:19:08 INFO - 'USER': 'cltbld', 07:19:08 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 07:19:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:08 INFO - '_': '/tools/buildbot/bin/python'} 07:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:09 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)) 07:19:09 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)) 07:19:09 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)) 07:19:09 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)) 07:19:09 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)) 07:19:09 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)) 07:19:09 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)) 07:19:09 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)) 07:19:09 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)) 07:19:09 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)) 07:19:09 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)) 07:19:09 INFO - Cleaning up... 07:19:09 INFO - Return code: 0 07:19:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:19:09 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 0x7f22a1fc0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017f60>, '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 0x1018d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:19:09 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 07:19:09 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 07:19:09 INFO - Using env: {'DISPLAY': ':0', 07:19:09 INFO - 'HOME': '/home/cltbld', 07:19:09 INFO - 'LANG': 'en_US.UTF-8', 07:19:09 INFO - 'LANGUAGE': 'en_US:en', 07:19:09 INFO - 'LOGNAME': 'cltbld', 07:19:09 INFO - 'MAIL': '/var/mail/cltbld', 07:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:09 INFO - 'MOZ_NO_REMOTE': '1', 07:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:09 INFO - 'NO_EM_RESTART': '1', 07:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:09 INFO - 'PWD': '/builds/slave/test', 07:19:09 INFO - 'SHELL': '/bin/bash', 07:19:09 INFO - 'SHLVL': '1', 07:19:09 INFO - 'TERM': 'linux', 07:19:09 INFO - 'TMOUT': '86400', 07:19:09 INFO - 'USER': 'cltbld', 07:19:09 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 07:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:09 INFO - '_': '/tools/buildbot/bin/python'} 07:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:19:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:19:09 INFO - Cleaning up... 07:19:09 INFO - Return code: 0 07:19:09 INFO - Running post-action listener: _resource_record_post_action 07:19:09 INFO - Running post-action listener: _start_resource_monitoring 07:19:09 INFO - Starting resource monitoring. 07:19:09 INFO - [mozharness: 2016-11-04 14:19:09.291987Z] Finished create-virtualenv step (success) 07:19:09 INFO - [mozharness: 2016-11-04 14:19:09.292446Z] Running install step. 07:19:09 INFO - Running pre-action listener: _resource_record_pre_action 07:19:09 INFO - Running main action method: install 07:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:19:09 INFO - Reading from file tmpfile_stdout 07:19:09 INFO - Detecting whether we're running mozinstall >=1.0... 07:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:19:09 INFO - Reading from file tmpfile_stdout 07:19:09 INFO - Output received: 07:19:09 INFO - Usage: mozinstall [options] installer 07:19:09 INFO - Options: 07:19:09 INFO - -h, --help show this help message and exit 07:19:09 INFO - -d DEST, --destination=DEST 07:19:09 INFO - Directory to install application into. [default: 07:19:09 INFO - "/builds/slave/test"] 07:19:09 INFO - --app=APP Application being installed. [default: firefox] 07:19:09 INFO - mkdir: /builds/slave/test/build/application 07:19:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:19:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:19:26 INFO - Reading from file tmpfile_stdout 07:19:26 INFO - Output received: 07:19:26 INFO - /builds/slave/test/build/application/firefox/firefox 07:19:26 INFO - Running post-action listener: _resource_record_post_action 07:19:26 INFO - [mozharness: 2016-11-04 14:19:26.112744Z] Finished install step (success) 07:19:26 INFO - [mozharness: 2016-11-04 14:19:26.112991Z] Running run-tests step. 07:19:26 INFO - Running pre-action listener: _resource_record_pre_action 07:19:26 INFO - Running main action method: run_tests 07:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:19:26 INFO - Python 2.7.3 07:19:26 INFO - Return code: 0 07:19:26 INFO - grabbing minidump binary from tooltool 07:19:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:19:26 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/linux64/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 0x1017f60>, '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 0x1018d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10191d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:19:26 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:19:26 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/linux64/releng.manifest -o -c /builds/tooltool_cache 07:19:26 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:19:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:19:26 INFO - Return code: 0 07:19:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:19:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:19:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:19:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:19:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:19:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 07:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --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 07:19:26 INFO - Using env: {'DISPLAY': ':0', 07:19:26 INFO - 'HOME': '/home/cltbld', 07:19:26 INFO - 'LANG': 'en_US.UTF-8', 07:19:26 INFO - 'LANGUAGE': 'en_US:en', 07:19:26 INFO - 'LOGNAME': 'cltbld', 07:19:26 INFO - 'MAIL': '/var/mail/cltbld', 07:19:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:19:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:19:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:19:26 INFO - 'MOZ_NO_REMOTE': '1', 07:19:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:19:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:19:26 INFO - 'NO_EM_RESTART': '1', 07:19:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:19:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:19:26 INFO - 'PWD': '/builds/slave/test', 07:19:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:19:26 INFO - 'SHELL': '/bin/bash', 07:19:26 INFO - 'SHLVL': '1', 07:19:26 INFO - 'TERM': 'linux', 07:19:26 INFO - 'TMOUT': '86400', 07:19:26 INFO - 'USER': 'cltbld', 07:19:26 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044', 07:19:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:19:26 INFO - '_': '/tools/buildbot/bin/python'} 07:19:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--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 07:19:26 INFO - mozversion application_buildid: 20161104043821 07:19:26 INFO - mozversion application_changeset: f29e3dc3f53e186ff2822be1d28f50b2e76853d2 07:19:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:19:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:19:26 INFO - mozversion application_name: Firefox 07:19:26 INFO - mozversion application_remotingname: firefox-dev 07:19:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:19:26 INFO - mozversion application_vendor: Mozilla 07:19:26 INFO - mozversion application_version: 51.0a2 07:19:26 INFO - mozversion platform_buildid: 20161104043821 07:19:26 INFO - mozversion platform_changeset: f29e3dc3f53e186ff2822be1d28f50b2e76853d2 07:19:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:19:26 INFO - mozversion platform_version: 51.0a2 07:19:26 INFO - using testdate: 1478269166 07:19:26 INFO - actual date: 1478269166 07:19:26 INFO - starting webserver on 'localhost:53032' 07:19:26 INFO - SUITE-START | Running 2 tests 07:19:26 INFO - TEST-START | dromaeo_css 07:19:26 INFO - operating with platform_type : linux_ 07:19:26 INFO - Initialising browser for dromaeo_css test... 07:19:26 INFO - TEST-INFO | started process 7434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHoWlVl/profile http://localhost:53032/getInfo.html) 07:19:30 INFO - PROCESS | 7434 | __metrics Screen width/height:1600/1200 07:19:30 INFO - PROCESS | 7434 | colorDepth:24 07:19:30 INFO - PROCESS | 7434 | Browser inner width/height: 1024/697 07:19:30 INFO - PROCESS | 7434 | __metrics 07:19:31 INFO - PROCESS | 7434 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:19:31 INFO - PROCESS | 7434 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:19:31 INFO - PROCESS | 7434 | console.error: PushService: 07:19:31 INFO - PROCESS | 7434 | stateChangeProcessEnqueue: Error transitioning state 07:19:31 INFO - PROCESS | 7434 | UnknownError 07:19:32 INFO - TEST-INFO | 7434: exit 0 07:19:32 INFO - Browser initialized. 07:19:32 INFO - Running cycle 1/1 for dromaeo_css test... 07:19:32 INFO - TEST-INFO | started process 7527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHoWlVl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:43 INFO - PROCESS | 7527 | RSS: Main: 145784832 07:19:43 INFO - PROCESS | 7527 | 07:20:35 INFO - PROCESS | 7527 | 1478269235102 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:22:44 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:53032/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53032/tests/dromaeo/cssquery-ext.html) 07:22:45 INFO - PROCESS | 7527 | RSS: Main: 234725376 07:22:45 INFO - PROCESS | 7527 | 07:25:47 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:53032/tests/dromaeo/cssquery-ext.html (next: http://localhost:53032/tests/dromaeo/cssquery-jquery.html) 07:25:48 INFO - PROCESS | 7527 | RSS: Main: 239616000 07:25:48 INFO - PROCESS | 7527 | 07:28:50 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:53032/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53032/tests/dromaeo/cssquery-mootools.html) 07:28:50 INFO - PROCESS | 7527 | RSS: Main: 229212160 07:28:50 INFO - PROCESS | 7527 | 07:31:52 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:53032/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53032/tests/dromaeo/cssquery-prototype.html) 07:31:53 INFO - PROCESS | 7527 | RSS: Main: 231096320 07:31:53 INFO - PROCESS | 7527 | 07:34:56 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:53032/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53032/tests/dromaeo/cssquery-yui.html) 07:34:56 INFO - PROCESS | 7527 | RSS: Main: 173420544 07:34:56 INFO - PROCESS | 7527 | 07:37:59 INFO - PROCESS | 7527 | Cycle 1(1): loaded http://localhost:53032/tests/dromaeo/cssquery-yui.html (next: http://localhost:53032/tests/dromaeo/cssquery-dojo.html) 07:37:59 INFO - PROCESS | 7527 | RSS: Main: 252534784 07:37:59 INFO - PROCESS | 7527 | 07:37:59 INFO - PROCESS | 7527 | __start_tp_report 07:37:59 INFO - PROCESS | 7527 | _x_x_mozilla_page_load 07:37:59 INFO - PROCESS | 7527 | _x_x_mozilla_page_load_details 07:37:59 INFO - PROCESS | 7527 | |i|pagename|runs| 07:37:59 INFO - PROCESS | 7527 | |0;dojo.html;3078.769092318076;3110.1758034120962;3119.5164749463825;3139.042592009439;3155.447796635588;5482.5613950883935;5570.442955704428;5573.804916827912;5617.8033768818095;5624.100143976964;5617.354004289508;5676.545876329894;5680.602357834953;5681.659100453976;5688.033034384154;5098.541131298182;5114.514121158484;5115.10485665009;5201.8439446816465;5233.58131349493;5030.5975521958335;5161.148410512261;5190.71451070191;5196.92204616931;5197;5004.499550044985;5012.69923804571;5072.39131304244;5114.02833461643;5118.436971933084;5049.798008079691;5075.974620126913;5080.339555857715;5151.896962060775;5174.016936781999;4980.477049909744;5045.117104506697;5094;5107.846764597068;5111.05445492585;5400;5446.591505637093;5512.641678290898;5540.501354878081;5594.524465420444;5939.227900372967;5961.612495187799;5968;6054.243219597551;6059.969700151471;6078.331383547807;6085.4523092921845;6092.66490343031;6095.9695201524155;6107.725152368154;5400.054990376708;5442.591805614556;5515.696636685021;5573.359063707726;5580.609357345028;6128.63228206309;6129.019356902874;6130.111133885651;6130.601510901777;6132.570720049643;5889.793857214977;5895.41045895407;5895.675737834375;5902.321233058254;5906.202662640489;5775.075987841925;5820.039693450533;5931.932252194646;5975.970120149372;5989.251343582052;6015.4586087252355;6018.097285407136;6019.067044608093;6044.607100538451;6054.334023257438;5954.396294512768;5985.102234664835;6008.939910600925;6009.098635204667;6034.63792172471;4473.619742321874;4524.321351797257;4526.796294166705;4627.074585082997;4631.397918270671;4053.9797301013305;4064.918701625951;4095.4266402703647;4111.013356794348;4122.175564887035;5694.857628559319;5698.116791897262;5700.3444603871085;5705.1727499512335;5706.28671416073;5824.446677565625;5874.941250587525;6023.909641355383;6029.457348838626;6034.788782392595;5548.0845660466375;5570.387257401682;5600.075987462104;5674.943250567524;5688.402717714663;5132.666376685504;5166.6125040621355;5172.586193104617;5173.689578625294;5190.506901844319;6118.724657390339;6159.5072394208355;6171.228596425447;6179.752809887644;6187.535934804818;5852.473277405054;5911.379305172895;5952.642841429528;5993.340732519507;5998.070299103646;6186.628802271878;6229.127922091002;6234.189555357774;6239.313675495782;6247.156633854372;5913;5932.5586966937635;5933.080372542263;5935.762569497345;5968.612040217372;5768.740406681625;5878.588498805043;5911.261092363455;5944.494717949023;6014.789482368096;5878.588498805043;5882.205902203319;5883.794067207627;5906.320773111147;5908.5568582357355;5910.202122713378;5912.320083190488;5914.822555323347;5920.230370051866;5931.970340148444;5586.692731899622;5695.231143795535;5790.363060063305;5875.500582450369;5891.027980383189;5879.5002424794375;5938.73275702603;5949.137375080676;5975.521958243243;5980.790672326448;5737.483626473638;5784.392638772868;5799.391063938226;5800.24596802413;5809.099589563624 07:37:59 INFO - PROCESS | 7527 | |1;ext.html;592.6592209479551;630.5050535329766;635.0823060677324;645.4416929356108;645.7675236914707;34503.309933801305;37372;45188.774056129674;46206.30690539644;46403.30395044077;47801.043979120484;48253.51746482534;48289.51710482894;48340.75829620847;48355.27467087988;9329.860052099208;9456.196223320992;9485;9494.857577136348;9496.620135194584;8578.785530361729;8798.6920457784;11099.500522476508;11352.602658906899;11370.886291137065;11461.255018423817;11561.190716649839;11564.710882227928;11565.248258863188;11579.53681852725;11259.4370281486;11321.943390282995;11351.97832195098;11363.431828408546;11363.772724545504;11251.54993800247;11312.09503239747;11317.264377815416;11323.263987840764;11337.319760814378;45845.31232031522;46145.76927115377;46250;46255;46262.306065409044;3352.6312105668358;3438.5186073949667;3449.913752156191;3497.7726447780815;4096.959030409717;34504.30991380184;34871.1282217944;35181.472277915855;35412.645873541194;36405.45391819125;4653.930191047137;4654.86035418938;4677.532246775295;4702.764861756933;4798.592119669832;386471;387804;388738.99999999715;389473;389521;38695;65319.346806532274;65708.6714566424;65831.67084164548;65838;39882;39993.60006399957;40045.39931901024;40051.599484004786;40082.799586001885;17153.313867445413;17322.826771732372;17329;17355.913220433817;17378.565535861453;12995.28525931083;14170.929145354414;14276.214808185441;14321.069130506483;14345;8444.535550544779;9340.532973351304;9595.712128636153;9614.95192524033;9690.46702431373;3553.680168784822;3585.0678823506078;3609.855605775792;3632.0738211755834;3645.216278500135;994.7165057958447;1046.4349251404308;1070.4380200394698;1103.674416047268;1164.0861923390098;33650.15874603154;34479.4828077579;35709.8214508931;35955.92132236037;37497.62502374996;1109.4896347680158;1123.4270522033657;1140.0594509529672;1148.4889224295275;1196.1208511743862;17823.821761782216;18330.90834545819;18381.81618183828;18386.540336491697;18419.355322563915;630553;637177;637625;639074;639602;62750.37249627537;63401.36598634047;63457;63504.68247658825;63527;1292.3021568353172;1372.7597670407638;1380.9033367664367;1446.9421223151166;1458.9124652520882;31071.601777919597;34995.47506787349;35150.12124696903;35247.29505409929;35448;54841;55614;55820.72089639526;55829.44170558242;55875.720621396635;490270;494597;494877;494967;496661;31738;32175.51736723998;32220.677793221766;32347.029589112364;32425.351492969538;50538.2419263704;51165.17005721545;52414.21378679247;52497.737511312196;53019.20471192858;42015.579844201166;43642.69071927847;44620.33069504025;44948.55051449444;45683.77158114321;43355.78322108369;44560.33159502675;44649.42804575691;44936.55063449324;45466.31800523061;43560;43872;44845.32732008957;45058.32412513749;47048.764756176;37235;39520.60479395284;39854.083430528786;40025.199496009336;40212;29217.561736574393;29479;29525.409491809613;29550.704492955654;29929.251768705955 07:37:59 INFO - PROCESS | 7527 | |2;jquery.html;389.7622450305312;412.6863583676407;423.843178024131;424.66451503312373;448.22680875489783;14100.50648227311;15683.686326273468;20117.899410502945;20835.687464688002;21107.2612458564;20190.19239230429;20619.587608247824;20627.587448251026;20690.68963965538;20921.163153473844;5766.654000759968;5783.5951483396175;5836.387179346171;5868.061110222366;5872.5889187756875;4287.228298906196;4526.275795872661;5793.826185214451;5885.234919460464;5885.941140588604;6163.87672246557;6519.967400162993;6535.705893234815;6549.607023578576;6636.469082473391;6306.810795676114;6467.902981455282;6631.270560238394;6656.234533028715;6658.434033107192;5773.624714393551;5962.642241465526;5964.224650795369;5965.761369545213;5967.8209653710455;19836.7106138102;20402.183912643475;20431.284905028253;23411.648825267635;25527.489450211076;2407.325948734357;2549.7067837198774;2601.713811480736;2747.3818390862098;2951.144168191222;15333.693326133527;15385.846141538554;15436.3825446982;15752;15960;1923.913423895928;2000.1299434745931;2003.8597298189134;2073.2536286936693;2337.8480398774027;82850;83393;86445.56777216074;92670.536647317;99969.5001524995;18681.252749889853;18954.062120371364;19056.904715476612;19121.71317430212;19196.520086997938;34796;35179.64820351815;35225.47161792575;35293.82353088218;35711.64288357135;10762.139028877671;10962;11022.338659680445;11052;11245.100391968623;9096.8635470468;9100.499472528942;9146.725598231931;9349;9357.111074447917;9187.862182067274;9416.340856140141;9495.335326527214;9504.109520597649;9617.422954622605;3234.773565850415;3425.3491836550975;3459.290845376692;3492.5459690240104;3493.7554371193773;975.6780262513354;978.6917121106828;1005.5726316315537;1051.138066785244;1112.6105862947904;19328.806711932702;20217.191312347637;20312.796872031387;20429.387118386472;20812.27157049496;1003.2626019875386;1038.787048655024;1059.390850261103;1062.5112448273726;1113.3987646670869;10666.41334726582;11220.1023918088;11254.212205145725;11277.71805704864;11382.146339024606;373296;375927;379556;506690;531962;56793.43206567964;59874.70062649659;102870.48564757279;107786;111503.44248278707;1086.7554800170058;1093.081811278514;1111.4942701070993;1120.165476719849;1128.430142777892;17907.462776116736;18121.818781812013;18484.422791443892;18552.628947420704;18806.153723082767;40939;43483.130337392446;44115;44124;45867.54132458766;52123;60140.39859601348;60265.397346027734;61480.69259653673;62650.37349626445;8810.515421651615;8987.595558199766;9146.222571081533;9230.307726920642;9274.489903055397;7528.096628404626;10955.397453140155;12489.064195049781;13682.179069255877;13911.582652520441;11057.170712196457;11343.149263805082;11356.716082098013;11980.76038479243;12238.755224895274;10657.57369705203;11119.666410007712;11430.25703329281;11652.88347116518;12599.811002834782;7101.615185038868;11431.714207144887;12047.337396442928;12105.394730263628;12323;8081.595920204084;8137.308328792119;8215.630296636786;8338.749837504885;9667.033296670277;10387;10674.679759607225;11187.722641867005;11209.383483908137;11718.121140914636 07:37:59 INFO - PROCESS | 7527 | |3;mootools.html;1292.5669900583305;1472.3374481483331;1500.864922157006;1622.1402656592004;1768.0364201510176;7628.732994345199;8262.628181731821;8616.052234254243;8634.48193108414;8847.911520884789;8591.140885911405;8680.73957781266;8694.434861733982;8701.56492175392;8704.521251331174;2395.149721848745;2418.8790560471994;2421.2615152378517;2424.4181396464896;2425.575524283252;2366.6095094309417;2382.5473160099527;2412.9034838606435;2412.9276121716375;2414.5291668124723;2334.1363695432715;2342.4143964009;2346.8239882008916;2375.8336916415856;2380.33350661815;2268.920587779436;2324.2678556254727;2326.8371214015024;2334.789868911806;2336.2056900653774;2235.9888200559058;2301.505176387068;2305.6656784766114;2310.364649721323;2312.1213938703354;7566.167721550625;7782.143964163937;8604.956975215146;8700.042995270514;8701.347398945041;5053.646244762868;5253.6322457428;5259.263703081571;5293.417724050351;5350.3312085989255;3480.2517458746493;3501.8074005929666;3506.3513250048823;3557.839897204632;3572.07126147201;1266.5567051531891;1268.0743057567936;1271.9046071544578;1297.935103244834;1306.45129045801;11564;11584.536618535249;11587.826182607268;11592.362420066976;11618.941905290503;4407.845725399596;4613.40025796651;4717.080169367009;4733.952660473351;4741.715497070187;9344.813103738023;9371.250299975985;9382.155605995493;9382.812343753087;9382.85925711115;5309.2036194570355;5342.412334643186;5343.091674415358;5346.198070289488;5352.2506849041165;4722.268048452495;4733.195356789285;4899.534544218293;4936.679115857458;4938.0617682640905;4066.3493840985893;4091.468109145792;4103.753774773523;4158.7296825706235;4201.495820501559;1354.607163922471;1360.605424426905;1370.451819272299;1373.1280636795507;1377.738229736347;933.8225737109927;947.346331031586;948.1324588001901;971.2133172130597;1009.1876039787894;5534.916976245359;5606.719664016783;5646.181303710939;5702.429757024347;5941.792037278675;490.31111288639516;494.50055444001816;499.620288580674;504.57111455263464;506.95944324453956;3857.498525191707;3897.7466464679705;3932.508436445444;3953;3986.1031267964477;9556.378835375679;9723.513824308757;10283.434411107311;10343.37939723619;10424.426656533811;9550.522473876417;10559.260851740459;10560.47197640115;10560.47197640115;10577.418241996764;7256.8911466328045;7899.486533375312;7952.324052455606;8081.717139900193;8110.0673422557165;5654.915176272441;5748.971255143698;5794.565407594363;5802.47777700009;5894.322152952465;9812.754681132743;9819.9018009819;9876.85184722244;9881.258905581966;9923.503824808586;10074.597016119273;10081.344712593658;10095.848562271718;10101.949490252502;10229.181665466893;7514.0607424071995;7555.433342499225;7602.771916842504;7609.782434810404;7612.543247405173;8003.839923201387;8074.919250807652;8116.026076870813;8129.634166462642;8130.512169269863;7038.085048943604;7150.713971441084;7216.7113315466795;7365.1530074042175;7401.5189012714;6759.87999740434;6957.026016357815;6969.0940177776565;6972.616506092214;7171.533850299714;6734;6906.551074180162;6911.308869113049;6913.274106218976;6919.515633905578;4858.27125931099;4934.087193869145;4991.725455100004;4994.300797888226;5015.924761128659;4774.530521111643;4833;4867.683600565952;4942.986687728935;5049.697018178921 07:37:59 INFO - PROCESS | 7527 | |4;prototype.html;325.62553063976424;343.1318763528273;343.61686719307977;346.5494856686308;353.17357383722083;5444.4011158772555;5466.835994920159;5518.089515229983;5535.308086489189;5551.250581171541;5442.782288708447;5455.8363249102595;5473.589480788947;5474.124140137579;5477.698726570037;4293.420388247593;4306.8277268909205;4350.630196433307;4365.36702178184;4383.4739831220295;3873.8063096845185;4009.939850902239;4201.936970945439;4302.20409224293;4302.247106756321;4251.149770046003;4257.808398622069;4265.616094551489;4286.271333873234;4293.484781826185;4282.978585107086;4322.697411181219;4330.242207613671;4343;4345.109252603241;3669.119411341259;3674.5590529136407;3766.924661506782;3781.470594116826;3812.1232116613332;5225.99505284463;5238.319018527605;5240.6069544784295;5247.921281180786;5339.305890234284;4902.950970490285;4950.455449900508;4974.179260422026;4980.936723914802;4984.401871775374;5408.378036525771;5662.886742265173;5696.806729409166;5712.600117991742;5714.51426628737;4241.1941731071;4243.172581346638;4248.596383343577;4248.936265956013;4298.806553705091;5556.749946252428;5736.56975726818;6004.519638428916;6030.4572588467245;6052.788152414689;4309.913801723948;4311.892202694958;4324.0919406924895;4325.205039908466;4337.522872484024;4369.847055353048;4378.277584198571;4398.538153493901;4399.186150562156;4409.625181859514;4878.658493905464;4954.529319714621;5004.124278251292;5006.19900815875;5016.523430274118;5586.636868603609;5669.943300567024;5685.204071430003;5714.428557144252;5819.214406055128;1486.4425840309884;1508.1328236264192;1509.7810817431412;1519.5061604978425;1533.2333833083458;960.5677445149711;1000.7798284377425;1004.4826914139225;1008.3143462445461;1020;4899.216125419915;4916.164252077156;4930.260460930889;4933.925991110136;4938.38270216223;5172.818951336685;5193;5196.350456192976;5197.350331208599;5222.321098257202;4927.334809800703;4966.900661986812;4988.376452943382;5136.666116702402;5585.301837270341;3077.3691393264326;3121.9063428097193;3138.2625083105454;3138.7802853800013;3141.418837515067;6124.846878827976;6137.232845894263;6139.938600614026;6155.753769849156;6170.642458659087;5741.282339707536;6022.969885150546;6039.248617900847;6042.335343112254;6049.667268300285;6123.908141377794;6123.908141377794;6129.478994285447;6132.264128304632;6202.255729312511;5678.318601767649;5949.375315591974;5974.9103763444455;5978.461938425388;6045.879082418415;5834;5835.503982161394;5846.258394627527;5878.2358293421585;5884.529237661062;5670.234518340137;5812.041013232938;5976.7908123215475;5987.5808693391045;6123.173371594778;4204.873853784391;4220.366944958281;4231.344141658048;4231.492220933507;4239.321708526621;5792.507636850914;5964.075568286922;6002.609830361012;6009.188759517409;6010.819675409744;5745.511631511368;5764.36591974874;5784;5801.94198058014;5805.738741756547;5790;5801.216835727291;5804.477597016289;5806.312991250671;5820.708964551671;5517.779288828402;5683.943160568341;5710.000749868674;5740.770369185186;5769.711514424346;5782.739776709974;5787.016207244695;5827.271591051119;5845.620034697731;5881.94118058831;5697.316322041382;5728.713564321684;5739.818868829985;5769.3942136076785;5794 07:37:59 INFO - PROCESS | 7527 | |5;yui.html;734.0604026845637;736.4918206437558;744.084775725857;768.19339693322;782.9686812527499;14267.928660356696;15112.244387780622;15352.232388380578;15392;15759.290831912564;14637;14927.32827022784;14943.775843362359;14963.700725985474;14996;701.7333413302938;720.4308596208989;822.5106061893179;835.6364981233153;839.7102999465175;815.233680340481;835.6615570693879;842.5492361586553;844.7170197983683;844.7550210438965;874.8993865705462;877.5042101212795;877.5568337989306;877.714742708619;877.863931090682;726.2918654312003;744.9068866391701;873.9563021848913;874.8381549413378;875.011237301848;551.2860845205469;551.8289330307617;631.059721015688;645.554567348528;645.8869697802912;13644.863551364459;13649.454021839114;13651.863481365159;13673.589792306248;13716.108452950526;13714;13796.655083622889;13964.371603277878;14343.928280358532;14513.129212247299;13296.628216061492;13388.129771564818;13452.663683407894;13631.407304140028;13816.654583635389;4483.730976141442;4536.954630453686;4547.431571053618;4678.391809064799;4735.502772208937;82535.58732206361;85861.57069214614;86051.26718030444;86943.13056869413;87224.56387718084;11123.833142502868;11238.55045798159;11293.209475336811;11347.432628368548;11653.359065251323;20661.483462913246;20806.271780487612;20876.686849697267;20932.476688082614;21316.680249796267;8226.506409615442;8540.70107546233;8633.611487483078;8688.739337819876;8976.102389760972;4608.746518941491;5027.4218464877;5099.69401835891;5113.258577506241;5161.329027226437;3297.274599588087;3412.4540073588105;3422.0418282880833;3422.5379573757723;3423.726101911891;582.1500609110745;595.1994567306965;604.1360853978765;612.1582823617526;617.996910015447;657.8059472455637;683.480554778372;691.6265216782881;696.0186137546137;713.2475238623302;8892.244159246407;9037.548122593844;9052.773680658036;9090.591691480533;9228;659.1661548141604;676.9830754231085;678.8947713104477;706.7561691216522;739.2348918868945;4361.542038085955;4378.890527736832;4394;4476.574725401082;4485.46174459067;129723;130031;130570.34714826365;131504;136589;65285.347146528875;106455.46772266243;106642.46678766712;112141;112222;98199;100554.49722751339;101894;102807.48596256971;102902.48548757208;8219.630116644646;8490.448120872123;8565.57172141403;8577.528235946833;8704.564771761514;57785.71107144606;58004;59167.40832591791;59411.405885940585;60091.699541502014;74947.62526187334;85070;85697.57151214204;86190.56904715436;86491;11339.262947908359;11652.126090543412;11811.763764724828;11827.940860295643;11989.520419183134;12795.360231988177;12890;12932.741345173232;13108.344582771015;13146.802797957847;12403.503859845505;12454.43955022008;12463.750724985632;12562.560310389092;12591.622251332476;11090.112790976542;11496.712582185512;11829.349385783864;11930.821037684615;11946.163768536118;11100.944495277472;11514.712132196762;11750.529978800752;12032.819507707216;12207.572734954234;10527.789444211227;10728.409937453514;10845.349279043283;10987.945060274647;11288.717782055513;9988.800223995624;10644.254902156774;10764.192685548458;10983.450827458755;11865.912802616958 07:37:59 INFO - PROCESS | 7527 | __end_tp_report 07:37:59 INFO - PROCESS | 7527 | __start_cc_report 07:37:59 INFO - PROCESS | 7527 | _x_x_mozilla_cycle_collect,830 07:37:59 INFO - PROCESS | 7527 | __end_cc_report 07:37:59 INFO - PROCESS | 7527 | __startTimestamp1478270279394__endTimestamp 07:37:59 INFO - PROCESS | 7527 | 07:37:59 INFO - PROCESS | 7527 | ------- Summary: start ------- 07:37:59 INFO - PROCESS | 7527 | Number of tests: 6 07:37:59 INFO - PROCESS | 7527 | 07:37:59 INFO - PROCESS | 7527 | [#0] dojo.html Cycles:165 Average:5561.33 Median:5799.39 stddev:646.64 (11.2%) stddev-sans-first:618.60 07:37:59 INFO - PROCESS | 7527 | Values: 3078.8 3110.2 3119.5 3139.0 3155.4 5482.6 5570.4 5573.8 5617.8 5624.1 5617.4 5676.5 5680.6 5681.7 5688.0 5098.5 5114.5 5115.1 5201.8 5233.6 5030.6 5161.1 5190.7 5196.9 5197.0 5004.5 5012.7 5072.4 5114.0 5118.4 5049.8 5076.0 5080.3 5151.9 5174.0 4980.5 5045.1 5094.0 5107.8 5111.1 5400.0 5446.6 5512.6 5540.5 5594.5 5939.2 5961.6 5968.0 6054.2 6060.0 6078.3 6085.5 6092.7 6096.0 6107.7 5400.1 5442.6 5515.7 5573.4 5580.6 6128.6 6129.0 6130.1 6130.6 6132.6 5889.8 5895.4 5895.7 5902.3 5906.2 5775.1 5820.0 5931.9 5976.0 5989.3 6015.5 6018.1 6019.1 6044.6 6054.3 5954.4 5985.1 6008.9 6009.1 6034.6 4473.6 4524.3 4526.8 4627.1 4631.4 4054.0 4064.9 4095.4 4111.0 4122.2 5694.9 5698.1 5700.3 5705.2 5706.3 5824.4 5874.9 6023.9 6029.5 6034.8 5548.1 5570.4 5600.1 5674.9 5688.4 5132.7 5166.6 5172.6 5173.7 5190.5 6118.7 6159.5 6171.2 6179.8 6187.5 5852.5 5911.4 5952.6 5993.3 5998.1 6186.6 6229.1 6234.2 6239.3 6247.2 5913.0 5932.6 5933.1 5935.8 5968.6 5768.7 5878.6 5911.3 5944.5 6014.8 5878.6 5882.2 5883.8 5906.3 5908.6 5910.2 5912.3 5914.8 5920.2 5932.0 5586.7 5695.2 5790.4 5875.5 5891.0 5879.5 5938.7 5949.1 5975.5 5980.8 5737.5 5784.4 5799.4 5800.2 5809.1 07:37:59 INFO - PROCESS | 7527 | 07:37:59 INFO - PROCESS | 7527 | [#1] ext.html Cycles:180 Average:66547.27 Median:39687.34 stddev:137548.73 (346.6%) stddev-sans-first:137845.46 07:37:59 INFO - PROCESS | 7527 | Values: 592.7 630.5 635.1 645.4 645.8 34503.3 37372.0 45188.8 46206.3 46403.3 47801.0 48253.5 48289.5 48340.8 48355.3 9329.9 9456.2 9485.0 9494.9 9496.6 8578.8 8798.7 11099.5 11352.6 11370.9 11461.3 11561.2 11564.7 11565.2 11579.5 11259.4 11321.9 11352.0 11363.4 11363.8 11251.5 11312.1 11317.3 11323.3 11337.3 45845.3 46145.8 46250.0 46255.0 46262.3 3352.6 3438.5 3449.9 3497.8 4097.0 34504.3 34871.1 35181.5 35412.6 36405.5 4653.9 4654.9 4677.5 4702.8 4798.6 386471.0 387804.0 388739.0 389473.0 389521.0 38695.0 65319.3 65708.7 65831.7 65838.0 39882.0 39993.6 40045.4 40051.6 40082.8 17153.3 17322.8 17329.0 17355.9 17378.6 12995.3 14170.9 14276.2 14321.1 14345.0 8444.5 9340.5 9595.7 9615.0 9690.5 3553.7 3585.1 3609.9 3632.1 3645.2 994.7 1046.4 1070.4 1103.7 1164.1 33650.2 34479.5 35709.8 35955.9 37497.6 1109.5 1123.4 1140.1 1148.5 1196.1 17823.8 18330.9 18381.8 18386.5 18419.4 630553.0 637177.0 637625.0 639074.0 639602.0 62750.4 63401.4 63457.0 63504.7 63527.0 1292.3 1372.8 1380.9 1446.9 1458.9 31071.6 34995.5 35150.1 35247.3 35448.0 54841.0 55614.0 55820.7 55829.4 55875.7 490270.0 494597.0 494877.0 494967.0 496661.0 31738.0 32175.5 32220.7 32347.0 32425.4 50538.2 51165.2 52414.2 52497.7 53019.2 42015.6 43642.7 44620.3 44948.6 45683.8 43355.8 44560.3 44649.4 44936.6 45466.3 43560.0 43872.0 44845.3 45058.3 47048.8 37235.0 39520.6 39854.1 40025.2 40212.0 29217.6 29479.0 29525.4 29550.7 29929.3 07:37:59 INFO - PROCESS | 7527 | 07:37:59 INFO - PROCESS | 7527 | [#2] jquery.html Cycles:180 Average:28880.78 Median:14064.60 stddev:72824.55 (517.8%) stddev-sans-first:72997.42 07:37:59 INFO - PROCESS | 7527 | Values: 389.8 412.7 423.8 424.7 448.2 14100.5 15683.7 20117.9 20835.7 21107.3 20190.2 20619.6 20627.6 20690.7 20921.2 5766.7 5783.6 5836.4 5868.1 5872.6 4287.2 4526.3 5793.8 5885.2 5885.9 6163.9 6520.0 6535.7 6549.6 6636.5 6306.8 6467.9 6631.3 6656.2 6658.4 5773.6 5962.6 5964.2 5965.8 5967.8 19836.7 20402.2 20431.3 23411.6 25527.5 2407.3 2549.7 2601.7 2747.4 2951.1 15333.7 15385.8 15436.4 15752.0 15960.0 1923.9 2000.1 2003.9 2073.3 2337.8 82850.0 83393.0 86445.6 92670.5 99969.5 18681.3 18954.1 19056.9 19121.7 19196.5 34796.0 35179.6 35225.5 35293.8 35711.6 10762.1 10962.0 11022.3 11052.0 11245.1 9096.9 9100.5 9146.7 9349.0 9357.1 9187.9 9416.3 9495.3 9504.1 9617.4 3234.8 3425.3 3459.3 3492.5 3493.8 975.7 978.7 1005.6 1051.1 1112.6 19328.8 20217.2 20312.8 20429.4 20812.3 1003.3 1038.8 1059.4 1062.5 1113.4 10666.4 11220.1 11254.2 11277.7 11382.1 373296.0 375927.0 379556.0 506690.0 531962.0 56793.4 59874.7 102870.5 107786.0 111503.4 1086.8 1093.1 1111.5 1120.2 1128.4 17907.5 18121.8 18484.4 18552.6 18806.2 40939.0 43483.1 44115.0 44124.0 45867.5 52123.0 60140.4 60265.4 61480.7 62650.4 8810.5 8987.6 9146.2 9230.3 9274.5 7528.1 10955.4 12489.1 13682.2 13911.6 11057.2 11343.1 11356.7 11980.8 12238.8 10657.6 11119.7 11430.3 11652.9 12599.8 7101.6 11431.7 12047.3 12105.4 12323.0 8081.6 8137.3 8215.6 8338.7 9667.0 10387.0 10674.7 11187.7 11209.4 11718.1 07:37:59 INFO - PROCESS | 7527 | 07:37:59 INFO - PROCESS | 7527 | [#3] mootools.html Cycles:180 Average:5602.92 Median:2721.30 stddev:3096.53 (113.8%) stddev-sans-first:3088.27 07:37:59 INFO - PROCESS | 7527 | Values: 1292.6 1472.3 1500.9 1622.1 1768.0 7628.7 8262.6 8616.1 8634.5 8847.9 8591.1 8680.7 8694.4 8701.6 8704.5 2395.1 2418.9 2421.3 2424.4 2425.6 2366.6 2382.5 2412.9 2412.9 2414.5 2334.1 2342.4 2346.8 2375.8 2380.3 2268.9 2324.3 2326.8 2334.8 2336.2 2236.0 2301.5 2305.7 2310.4 2312.1 7566.2 7782.1 8605.0 8700.0 8701.3 5053.6 5253.6 5259.3 5293.4 5350.3 3480.3 3501.8 3506.4 3557.8 3572.1 1266.6 1268.1 1271.9 1297.9 1306.5 11564.0 11584.5 11587.8 11592.4 11618.9 4407.8 4613.4 4717.1 4734.0 4741.7 9344.8 9371.3 9382.2 9382.8 9382.9 5309.2 5342.4 5343.1 5346.2 5352.3 4722.3 4733.2 4899.5 4936.7 4938.1 4066.3 4091.5 4103.8 4158.7 4201.5 1354.6 1360.6 1370.5 1373.1 1377.7 933.8 947.3 948.1 971.2 1009.2 5534.9 5606.7 5646.2 5702.4 5941.8 490.3 494.5 499.6 504.6 507.0 3857.5 3897.7 3932.5 3953.0 3986.1 9556.4 9723.5 10283.4 10343.4 10424.4 9550.5 10559.3 10560.5 10560.5 10577.4 7256.9 7899.5 7952.3 8081.7 8110.1 5654.9 5749.0 5794.6 5802.5 5894.3 9812.8 9819.9 9876.9 9881.3 9923.5 10074.6 10081.3 10095.8 10101.9 10229.2 7514.1 7555.4 7602.8 7609.8 7612.5 8003.8 8074.9 8116.0 8129.6 8130.5 7038.1 7150.7 7216.7 7365.2 7401.5 6759.9 6957.0 6969.1 6972.6 7171.5 6734.0 6906.6 6911.3 6913.3 6919.5 4858.3 4934.1 4991.7 4994.3 5015.9 4774.5 4833.0 4867.7 4943.0 5049.7 07:37:59 INFO - PROCESS | 7527 | 07:37:59 INFO - PROCESS | 7527 | [#4] prototype.html Cycles:180 Average:4815.32 Median:5244.26 stddev:1401.01 (26.7%) stddev-sans-first:1363.81 07:37:59 INFO - PROCESS | 7527 | Values: 325.6 343.1 343.6 346.5 353.2 5444.4 5466.8 5518.1 5535.3 5551.3 5442.8 5455.8 5473.6 5474.1 5477.7 4293.4 4306.8 4350.6 4365.4 4383.5 3873.8 4009.9 4201.9 4302.2 4302.2 4251.1 4257.8 4265.6 4286.3 4293.5 4283.0 4322.7 4330.2 4343.0 4345.1 3669.1 3674.6 3766.9 3781.5 3812.1 5226.0 5238.3 5240.6 5247.9 5339.3 4903.0 4950.5 4974.2 4980.9 4984.4 5408.4 5662.9 5696.8 5712.6 5714.5 4241.2 4243.2 4248.6 4248.9 4298.8 5556.7 5736.6 6004.5 6030.5 6052.8 4309.9 4311.9 4324.1 4325.2 4337.5 4369.8 4378.3 4398.5 4399.2 4409.6 4878.7 4954.5 5004.1 5006.2 5016.5 5586.6 5669.9 5685.2 5714.4 5819.2 1486.4 1508.1 1509.8 1519.5 1533.2 960.6 1000.8 1004.5 1008.3 1020.0 4899.2 4916.2 4930.3 4933.9 4938.4 5172.8 5193.0 5196.4 5197.4 5222.3 4927.3 4966.9 4988.4 5136.7 5585.3 3077.4 3121.9 3138.3 3138.8 3141.4 6124.8 6137.2 6139.9 6155.8 6170.6 5741.3 6023.0 6039.2 6042.3 6049.7 6123.9 6123.9 6129.5 6132.3 6202.3 5678.3 5949.4 5974.9 5978.5 6045.9 5834.0 5835.5 5846.3 5878.2 5884.5 5670.2 5812.0 5976.8 5987.6 6123.2 4204.9 4220.4 4231.3 4231.5 4239.3 5792.5 5964.1 6002.6 6009.2 6010.8 5745.5 5764.4 5784.0 5801.9 5805.7 5790.0 5801.2 5804.5 5806.3 5820.7 5517.8 5683.9 5710.0 5740.8 5769.7 5782.7 5787.0 5827.3 5845.6 5881.9 5697.3 5728.7 5739.8 5769.4 5794.0 07:37:59 INFO - PROCESS | 7527 | 07:37:59 INFO - PROCESS | 7527 | [#5] yui.html Cycles:180 Average:22164.58 Median:4480.15 stddev:33865.71 (755.9%) stddev-sans-first:33922.48 07:37:59 INFO - PROCESS | 7527 | Values: 734.1 736.5 744.1 768.2 783.0 14267.9 15112.2 15352.2 15392.0 15759.3 14637.0 14927.3 14943.8 14963.7 14996.0 701.7 720.4 822.5 835.6 839.7 815.2 835.7 842.5 844.7 844.8 874.9 877.5 877.6 877.7 877.9 726.3 744.9 874.0 874.8 875.0 551.3 551.8 631.1 645.6 645.9 13644.9 13649.5 13651.9 13673.6 13716.1 13714.0 13796.7 13964.4 14343.9 14513.1 13296.6 13388.1 13452.7 13631.4 13816.7 4483.7 4537.0 4547.4 4678.4 4735.5 82535.6 85861.6 86051.3 86943.1 87224.6 11123.8 11238.6 11293.2 11347.4 11653.4 20661.5 20806.3 20876.7 20932.5 21316.7 8226.5 8540.7 8633.6 8688.7 8976.1 4608.7 5027.4 5099.7 5113.3 5161.3 3297.3 3412.5 3422.0 3422.5 3423.7 582.2 595.2 604.1 612.2 618.0 657.8 683.5 691.6 696.0 713.2 8892.2 9037.5 9052.8 9090.6 9228.0 659.2 677.0 678.9 706.8 739.2 4361.5 4378.9 4394.0 4476.6 4485.5 129723.0 130031.0 130570.3 131504.0 136589.0 65285.3 106455.5 106642.5 112141.0 112222.0 98199.0 100554.5 101894.0 102807.5 102902.5 8219.6 8490.4 8565.6 8577.5 8704.6 57785.7 58004.0 59167.4 59411.4 60091.7 74947.6 85070.0 85697.6 86190.6 86491.0 11339.3 11652.1 11811.8 11827.9 11989.5 12795.4 12890.0 12932.7 13108.3 13146.8 12403.5 12454.4 12463.8 12562.6 12591.6 11090.1 11496.7 11829.3 11930.8 11946.2 11100.9 11514.7 11750.5 12032.8 12207.6 10527.8 10728.4 10845.3 10987.9 11288.7 9988.8 10644.3 10764.2 10983.5 11865.9 07:37:59 INFO - PROCESS | 7527 | -------- Summary: end -------- 07:37:59 INFO - PROCESS | 7527 | 07:38:00 INFO - TEST-INFO | 7527: exit 0 07:38:00 INFO - TEST-OK | dromaeo_css | took 1113746ms 07:38:00 INFO - TEST-START | kraken 07:38:00 INFO - operating with platform_type : linux_ 07:38:00 INFO - Initialising browser for kraken test... 07:38:00 INFO - TEST-INFO | started process 7889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV5RTKV/profile http://localhost:53032/getInfo.html) 07:38:03 INFO - PROCESS | 7889 | __metrics Screen width/height:1600/1200 07:38:03 INFO - PROCESS | 7889 | colorDepth:24 07:38:03 INFO - PROCESS | 7889 | Browser inner width/height: 1024/697 07:38:03 INFO - PROCESS | 7889 | __metrics 07:38:04 INFO - PROCESS | 7889 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:38:04 INFO - PROCESS | 7889 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:38:05 INFO - PROCESS | 7889 | console.error: PushService: 07:38:05 INFO - PROCESS | 7889 | stateChangeProcessEnqueue: Error transitioning state 07:38:05 INFO - PROCESS | 7889 | UnknownError 07:38:05 INFO - TEST-INFO | 7889: exit 0 07:38:05 INFO - Browser initialized. 07:38:05 INFO - Running cycle 1/1 for kraken test... 07:38:05 INFO - TEST-INFO | started process 7982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV5RTKV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:17 INFO - PROCESS | 7982 | RSS: Main: 145498112 07:38:17 INFO - PROCESS | 7982 | 07:38:19 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53032/tests/kraken/driver.html?testName=audio-beat-detection) 07:38:20 INFO - PROCESS | 7982 | RSS: Main: 186863616 07:38:20 INFO - PROCESS | 7982 | 07:38:23 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53032/tests/kraken/driver.html?testName=audio-dft) 07:38:23 INFO - PROCESS | 7982 | RSS: Main: 176431104 07:38:23 INFO - PROCESS | 7982 | 07:38:26 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53032/tests/kraken/driver.html?testName=audio-fft) 07:38:27 INFO - PROCESS | 7982 | RSS: Main: 268267520 07:38:27 INFO - PROCESS | 7982 | 07:38:29 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53032/tests/kraken/driver.html?testName=audio-oscillator) 07:38:29 INFO - PROCESS | 7982 | RSS: Main: 173883392 07:38:29 INFO - PROCESS | 7982 | 07:38:32 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53032/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:38:32 INFO - PROCESS | 7982 | RSS: Main: 175792128 07:38:32 INFO - PROCESS | 7982 | 07:38:35 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53032/tests/kraken/driver.html?testName=imaging-darkroom) 07:38:36 INFO - PROCESS | 7982 | RSS: Main: 211828736 07:38:36 INFO - PROCESS | 7982 | 07:38:39 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53032/tests/kraken/driver.html?testName=imaging-desaturate) 07:38:40 INFO - PROCESS | 7982 | RSS: Main: 210636800 07:38:40 INFO - PROCESS | 7982 | 07:38:42 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53032/tests/kraken/driver.html?testName=json-parse-financial) 07:38:43 INFO - PROCESS | 7982 | RSS: Main: 210219008 07:38:43 INFO - PROCESS | 7982 | 07:38:44 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53032/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:38:45 INFO - PROCESS | 7982 | RSS: Main: 172101632 07:38:45 INFO - PROCESS | 7982 | 07:38:47 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53032/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:38:47 INFO - PROCESS | 7982 | RSS: Main: 179281920 07:38:47 INFO - PROCESS | 7982 | 07:38:49 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53032/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:38:50 INFO - PROCESS | 7982 | RSS: Main: 188837888 07:38:50 INFO - PROCESS | 7982 | 07:38:52 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:38:53 INFO - PROCESS | 7982 | RSS: Main: 197808128 07:38:53 INFO - PROCESS | 7982 | 07:38:56 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:38:56 INFO - PROCESS | 7982 | RSS: Main: 194441216 07:38:56 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | Cycle 1(1): loaded http://localhost:53032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53032/tests/kraken/driver.html?testName=ai-astar) 07:38:58 INFO - PROCESS | 7982 | RSS: Main: 243224576 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | __start_tp_report 07:38:58 INFO - PROCESS | 7982 | _x_x_mozilla_page_load 07:38:58 INFO - PROCESS | 7982 | _x_x_mozilla_page_load_details 07:38:58 INFO - PROCESS | 7982 | |i|pagename|runs| 07:38:58 INFO - PROCESS | 7982 | |0;ai-astar;110;111;110;111;112;113;111;112;111;113 07:38:58 INFO - PROCESS | 7982 | |1;audio-beat-detection;148;117;118;143;124;123;115;122;157;123 07:38:58 INFO - PROCESS | 7982 | |2;audio-dft;161;160;161;161;161;162;161;160;161;160 07:38:58 INFO - PROCESS | 7982 | |3;audio-fft;75;75;75;117;75;76;75;77;96;75 07:38:58 INFO - PROCESS | 7982 | |4;audio-oscillator;80;80;111;80;80;81;100;80;79;107 07:38:58 INFO - PROCESS | 7982 | |5;imaging-gaussian-blur;116;116;117;116;117;116;117;117;117;117 07:38:58 INFO - PROCESS | 7982 | |6;imaging-darkroom;146;146;146;146;146;146;145;147;146;145 07:38:58 INFO - PROCESS | 7982 | |7;imaging-desaturate;95;94;94;95;94;94;95;94;95;95 07:38:58 INFO - PROCESS | 7982 | |8;json-parse-financial;50;49;48;49;48;51;49;48;48;48 07:38:58 INFO - PROCESS | 7982 | |9;json-stringify-tinderbox;59;58;58;58;59;58;59;58;59;59 07:38:58 INFO - PROCESS | 7982 | |10;stanford-crypto-aes;82;76;73;73;81;73;74;81;73;73 07:38:58 INFO - PROCESS | 7982 | |11;stanford-crypto-ccm;133;123;130;132;121;121;117;117;168;122 07:38:58 INFO - PROCESS | 7982 | |12;stanford-crypto-pbkdf2;154;153;159;153;153;154;153;154;153;152 07:38:58 INFO - PROCESS | 7982 | |13;stanford-crypto-sha256-iterative;63;64;63;62;62;63;62;61;61;61 07:38:58 INFO - PROCESS | 7982 | __end_tp_report 07:38:58 INFO - PROCESS | 7982 | __start_cc_report 07:38:58 INFO - PROCESS | 7982 | _x_x_mozilla_cycle_collect,1570 07:38:58 INFO - PROCESS | 7982 | __end_cc_report 07:38:58 INFO - PROCESS | 7982 | __startTimestamp1478270338800__endTimestamp 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | ------- Summary: start ------- 07:38:58 INFO - PROCESS | 7982 | Number of tests: 14 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:1.07 (1.0%) stddev-sans-first:1.01 07:38:58 INFO - PROCESS | 7982 | Values: 110.0 111.0 110.0 111.0 112.0 113.0 111.0 112.0 111.0 113.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:123.50 stddev:14.71 (11.9%) stddev-sans-first:13.91 07:38:58 INFO - PROCESS | 7982 | Values: 148.0 117.0 118.0 143.0 124.0 123.0 115.0 122.0 157.0 123.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:38:58 INFO - PROCESS | 7982 | Values: 161.0 160.0 161.0 161.0 161.0 162.0 161.0 160.0 161.0 160.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#3] audio-fft Cycles:10 Average:81.60 Median:75.00 stddev:14.04 (18.7%) stddev-sans-first:14.69 07:38:58 INFO - PROCESS | 7982 | Values: 75.0 75.0 75.0 117.0 75.0 76.0 75.0 77.0 96.0 75.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:80.00 stddev:12.84 (16.0%) stddev-sans-first:13.30 07:38:58 INFO - PROCESS | 7982 | Values: 80.0 80.0 111.0 80.0 80.0 81.0 100.0 80.0 79.0 107.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 07:38:58 INFO - PROCESS | 7982 | Values: 116.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:38:58 INFO - PROCESS | 7982 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 146.0 145.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 07:38:58 INFO - PROCESS | 7982 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#8] json-parse-financial Cycles:10 Average:48.80 Median:49.00 stddev:1.03 (2.1%) stddev-sans-first:1.00 07:38:58 INFO - PROCESS | 7982 | Values: 50.0 49.0 48.0 49.0 48.0 51.0 49.0 48.0 48.0 48.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 07:38:58 INFO - PROCESS | 7982 | Values: 59.0 58.0 58.0 58.0 59.0 58.0 59.0 58.0 59.0 59.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.00 stddev:3.87 (5.2%) stddev-sans-first:3.42 07:38:58 INFO - PROCESS | 7982 | Values: 82.0 76.0 73.0 73.0 81.0 73.0 74.0 81.0 73.0 73.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:126.50 stddev:15.07 (11.9%) stddev-sans-first:15.89 07:38:58 INFO - PROCESS | 7982 | Values: 133.0 123.0 130.0 132.0 121.0 121.0 117.0 117.0 168.0 122.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.80 Median:153.50 stddev:1.93 (1.3%) stddev-sans-first:2.05 07:38:58 INFO - PROCESS | 7982 | Values: 154.0 153.0 159.0 153.0 153.0 154.0 153.0 154.0 153.0 152.0 07:38:58 INFO - PROCESS | 7982 | 07:38:58 INFO - PROCESS | 7982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:1.03 (1.7%) stddev-sans-first:1.05 07:38:58 INFO - PROCESS | 7982 | Values: 63.0 64.0 63.0 62.0 62.0 63.0 62.0 61.0 61.0 61.0 07:38:58 INFO - PROCESS | 7982 | -------- Summary: end -------- 07:38:58 INFO - PROCESS | 7982 | 07:38:59 INFO - TEST-INFO | 7982: exit 0 07:39:00 INFO - TEST-OK | kraken | took 59856ms 07:39:00 INFO - SUITE-END | took 1173s 07:39:00 INFO - Completed test suite (00:19:34) 07:39:00 INFO - javascript benchmark 07:39:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3078.769092318076, 3110.1758034120962, 3119.5164749463825, 3139.042592009439, 3155.447796635588, 5482.5613950883935, 5570.442955704428, 5573.804916827912, 5617.8033768818095, 5624.100143976964, 5617.354004289508, 5676.545876329894, 5680.602357834953, 5681.659100453976, 5688.033034384154, 5098.541131298182, 5114.514121158484, 5115.10485665009, 5201.8439446816465, 5233.58131349493, 5030.5975521958335, 5161.148410512261, 5190.71451070191, 5196.92204616931, 5197.0, 5004.499550044985, 5012.69923804571, 5072.39131304244, 5114.02833461643, 5118.436971933084, 5049.798008079691, 5075.974620126913, 5080.339555857715, 5151.896962060775, 5174.016936781999, 4980.477049909744, 5045.117104506697, 5094.0, 5107.846764597068, 5111.05445492585, 5400.0, 5446.591505637093, 5512.641678290898, 5540.501354878081, 5594.524465420444, 5939.227900372967, 5961.612495187799, 5968.0, 6054.243219597551, 6059.969700151471, 6078.331383547807, 6085.4523092921845, 6092.66490343031, 6095.9695201524155, 6107.725152368154, 5400.054990376708, 5442.591805614556, 5515.696636685021, 5573.359063707726, 5580.609357345028, 6128.63228206309, 6129.019356902874, 6130.111133885651, 6130.601510901777, 6132.570720049643, 5889.793857214977, 5895.41045895407, 5895.675737834375, 5902.321233058254, 5906.202662640489, 5775.075987841925, 5820.039693450533, 5931.932252194646, 5975.970120149372, 5989.251343582052, 6015.4586087252355, 6018.097285407136, 6019.067044608093, 6044.607100538451, 6054.334023257438, 5954.396294512768, 5985.102234664835, 6008.939910600925, 6009.098635204667, 6034.63792172471, 4473.619742321874, 4524.321351797257, 4526.796294166705, 4627.074585082997, 4631.397918270671, 4053.9797301013305, 4064.918701625951, 4095.4266402703647, 4111.013356794348, 4122.175564887035, 5694.857628559319, 5698.116791897262, 5700.3444603871085, 5705.1727499512335, 5706.28671416073, 5824.446677565625, 5874.941250587525, 6023.909641355383, 6029.457348838626, 6034.788782392595, 5548.0845660466375, 5570.387257401682, 5600.075987462104, 5674.943250567524, 5688.402717714663, 5132.666376685504, 5166.6125040621355, 5172.586193104617, 5173.689578625294, 5190.506901844319, 6118.724657390339, 6159.5072394208355, 6171.228596425447, 6179.752809887644, 6187.535934804818, 5852.473277405054, 5911.379305172895, 5952.642841429528, 5993.340732519507, 5998.070299103646, 6186.628802271878, 6229.127922091002, 6234.189555357774, 6239.313675495782, 6247.156633854372, 5913.0, 5932.5586966937635, 5933.080372542263, 5935.762569497345, 5968.612040217372, 5768.740406681625, 5878.588498805043, 5911.261092363455, 5944.494717949023, 6014.789482368096, 5878.588498805043, 5882.205902203319, 5883.794067207627, 5906.320773111147, 5908.5568582357355, 5910.202122713378, 5912.320083190488, 5914.822555323347, 5920.230370051866, 5931.970340148444, 5586.692731899622, 5695.231143795535, 5790.363060063305, 5875.500582450369, 5891.027980383189, 5879.5002424794375, 5938.73275702603, 5949.137375080676, 5975.521958243243, 5980.790672326448, 5737.483626473638, 5784.392638772868, 5799.391063938226, 5800.24596802413, 5809.099589563624], "value": 5515.80450438876, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.6592209479551, 630.5050535329766, 635.0823060677324, 645.4416929356108, 645.7675236914707, 34503.309933801305, 37372.0, 45188.774056129674, 46206.30690539644, 46403.30395044077, 47801.043979120484, 48253.51746482534, 48289.51710482894, 48340.75829620847, 48355.27467087988, 9329.860052099208, 9456.196223320992, 9485.0, 9494.857577136348, 9496.620135194584, 8578.785530361729, 8798.6920457784, 11099.500522476508, 11352.602658906899, 11370.886291137065, 11461.255018423817, 11561.190716649839, 11564.710882227928, 11565.248258863188, 11579.53681852725, 11259.4370281486, 11321.943390282995, 11351.97832195098, 11363.431828408546, 11363.772724545504, 11251.54993800247, 11312.09503239747, 11317.264377815416, 11323.263987840764, 11337.319760814378, 45845.31232031522, 46145.76927115377, 46250.0, 46255.0, 46262.306065409044, 3352.6312105668358, 3438.5186073949667, 3449.913752156191, 3497.7726447780815, 4096.959030409717, 34504.30991380184, 34871.1282217944, 35181.472277915855, 35412.645873541194, 36405.45391819125, 4653.930191047137, 4654.86035418938, 4677.532246775295, 4702.764861756933, 4798.592119669832, 386471.0, 387804.0, 388738.99999999715, 389473.0, 389521.0, 38695.0, 65319.346806532274, 65708.6714566424, 65831.67084164548, 65838.0, 39882.0, 39993.60006399957, 40045.39931901024, 40051.599484004786, 40082.799586001885, 17153.313867445413, 17322.826771732372, 17329.0, 17355.913220433817, 17378.565535861453, 12995.28525931083, 14170.929145354414, 14276.214808185441, 14321.069130506483, 14345.0, 8444.535550544779, 9340.532973351304, 9595.712128636153, 9614.95192524033, 9690.46702431373, 3553.680168784822, 3585.0678823506078, 3609.855605775792, 3632.0738211755834, 3645.216278500135, 994.7165057958447, 1046.4349251404308, 1070.4380200394698, 1103.674416047268, 1164.0861923390098, 33650.15874603154, 34479.4828077579, 35709.8214508931, 35955.92132236037, 37497.62502374996, 1109.4896347680158, 1123.4270522033657, 1140.0594509529672, 1148.4889224295275, 1196.1208511743862, 17823.821761782216, 18330.90834545819, 18381.81618183828, 18386.540336491697, 18419.355322563915, 630553.0, 637177.0, 637625.0, 639074.0, 639602.0, 62750.37249627537, 63401.36598634047, 63457.0, 63504.68247658825, 63527.0, 1292.3021568353172, 1372.7597670407638, 1380.9033367664367, 1446.9421223151166, 1458.9124652520882, 31071.601777919597, 34995.47506787349, 35150.12124696903, 35247.29505409929, 35448.0, 54841.0, 55614.0, 55820.72089639526, 55829.44170558242, 55875.720621396635, 490270.0, 494597.0, 494877.0, 494967.0, 496661.0, 31738.0, 32175.51736723998, 32220.677793221766, 32347.029589112364, 32425.351492969538, 50538.2419263704, 51165.17005721545, 52414.21378679247, 52497.737511312196, 53019.20471192858, 42015.579844201166, 43642.69071927847, 44620.33069504025, 44948.55051449444, 45683.77158114321, 43355.78322108369, 44560.33159502675, 44649.42804575691, 44936.55063449324, 45466.31800523061, 43560.0, 43872.0, 44845.32732008957, 45058.32412513749, 47048.764756176, 37235.0, 39520.60479395284, 39854.083430528786, 40025.199496009336, 40212.0, 29217.561736574393, 29479.0, 29525.409491809613, 29550.704492955654, 29929.251768705955], "value": 20790.48158739211, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.7622450305312, 412.6863583676407, 423.843178024131, 424.66451503312373, 448.22680875489783, 14100.50648227311, 15683.686326273468, 20117.899410502945, 20835.687464688002, 21107.2612458564, 20190.19239230429, 20619.587608247824, 20627.587448251026, 20690.68963965538, 20921.163153473844, 5766.654000759968, 5783.5951483396175, 5836.387179346171, 5868.061110222366, 5872.5889187756875, 4287.228298906196, 4526.275795872661, 5793.826185214451, 5885.234919460464, 5885.941140588604, 6163.87672246557, 6519.967400162993, 6535.705893234815, 6549.607023578576, 6636.469082473391, 6306.810795676114, 6467.902981455282, 6631.270560238394, 6656.234533028715, 6658.434033107192, 5773.624714393551, 5962.642241465526, 5964.224650795369, 5965.761369545213, 5967.8209653710455, 19836.7106138102, 20402.183912643475, 20431.284905028253, 23411.648825267635, 25527.489450211076, 2407.325948734357, 2549.7067837198774, 2601.713811480736, 2747.3818390862098, 2951.144168191222, 15333.693326133527, 15385.846141538554, 15436.3825446982, 15752.0, 15960.0, 1923.913423895928, 2000.1299434745931, 2003.8597298189134, 2073.2536286936693, 2337.8480398774027, 82850.0, 83393.0, 86445.56777216074, 92670.536647317, 99969.5001524995, 18681.252749889853, 18954.062120371364, 19056.904715476612, 19121.71317430212, 19196.520086997938, 34796.0, 35179.64820351815, 35225.47161792575, 35293.82353088218, 35711.64288357135, 10762.139028877671, 10962.0, 11022.338659680445, 11052.0, 11245.100391968623, 9096.8635470468, 9100.499472528942, 9146.725598231931, 9349.0, 9357.111074447917, 9187.862182067274, 9416.340856140141, 9495.335326527214, 9504.109520597649, 9617.422954622605, 3234.773565850415, 3425.3491836550975, 3459.290845376692, 3492.5459690240104, 3493.7554371193773, 975.6780262513354, 978.6917121106828, 1005.5726316315537, 1051.138066785244, 1112.6105862947904, 19328.806711932702, 20217.191312347637, 20312.796872031387, 20429.387118386472, 20812.27157049496, 1003.2626019875386, 1038.787048655024, 1059.390850261103, 1062.5112448273726, 1113.3987646670869, 10666.41334726582, 11220.1023918088, 11254.212205145725, 11277.71805704864, 11382.146339024606, 373296.0, 375927.0, 379556.0, 506690.0, 531962.0, 56793.43206567964, 59874.70062649659, 102870.48564757279, 107786.0, 111503.44248278707, 1086.7554800170058, 1093.081811278514, 1111.4942701070993, 1120.165476719849, 1128.430142777892, 17907.462776116736, 18121.818781812013, 18484.422791443892, 18552.628947420704, 18806.153723082767, 40939.0, 43483.130337392446, 44115.0, 44124.0, 45867.54132458766, 52123.0, 60140.39859601348, 60265.397346027734, 61480.69259653673, 62650.37349626445, 8810.515421651615, 8987.595558199766, 9146.222571081533, 9230.307726920642, 9274.489903055397, 7528.096628404626, 10955.397453140155, 12489.064195049781, 13682.179069255877, 13911.582652520441, 11057.170712196457, 11343.149263805082, 11356.716082098013, 11980.76038479243, 12238.755224895274, 10657.57369705203, 11119.666410007712, 11430.25703329281, 11652.88347116518, 12599.811002834782, 7101.615185038868, 11431.714207144887, 12047.337396442928, 12105.394730263628, 12323.0, 8081.595920204084, 8137.308328792119, 8215.630296636786, 8338.749837504885, 9667.033296670277, 10387.0, 10674.679759607225, 11187.722641867005, 11209.383483908137, 11718.121140914636], "value": 10331.556020822438, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.5669900583305, 1472.3374481483331, 1500.864922157006, 1622.1402656592004, 1768.0364201510176, 7628.732994345199, 8262.628181731821, 8616.052234254243, 8634.48193108414, 8847.911520884789, 8591.140885911405, 8680.73957781266, 8694.434861733982, 8701.56492175392, 8704.521251331174, 2395.149721848745, 2418.8790560471994, 2421.2615152378517, 2424.4181396464896, 2425.575524283252, 2366.6095094309417, 2382.5473160099527, 2412.9034838606435, 2412.9276121716375, 2414.5291668124723, 2334.1363695432715, 2342.4143964009, 2346.8239882008916, 2375.8336916415856, 2380.33350661815, 2268.920587779436, 2324.2678556254727, 2326.8371214015024, 2334.789868911806, 2336.2056900653774, 2235.9888200559058, 2301.505176387068, 2305.6656784766114, 2310.364649721323, 2312.1213938703354, 7566.167721550625, 7782.143964163937, 8604.956975215146, 8700.042995270514, 8701.347398945041, 5053.646244762868, 5253.6322457428, 5259.263703081571, 5293.417724050351, 5350.3312085989255, 3480.2517458746493, 3501.8074005929666, 3506.3513250048823, 3557.839897204632, 3572.07126147201, 1266.5567051531891, 1268.0743057567936, 1271.9046071544578, 1297.935103244834, 1306.45129045801, 11564.0, 11584.536618535249, 11587.826182607268, 11592.362420066976, 11618.941905290503, 4407.845725399596, 4613.40025796651, 4717.080169367009, 4733.952660473351, 4741.715497070187, 9344.813103738023, 9371.250299975985, 9382.155605995493, 9382.812343753087, 9382.85925711115, 5309.2036194570355, 5342.412334643186, 5343.091674415358, 5346.198070289488, 5352.2506849041165, 4722.268048452495, 4733.195356789285, 4899.534544218293, 4936.679115857458, 4938.0617682640905, 4066.3493840985893, 4091.468109145792, 4103.753774773523, 4158.7296825706235, 4201.495820501559, 1354.607163922471, 1360.605424426905, 1370.451819272299, 1373.1280636795507, 1377.738229736347, 933.8225737109927, 947.346331031586, 948.1324588001901, 971.2133172130597, 1009.1876039787894, 5534.916976245359, 5606.719664016783, 5646.181303710939, 5702.429757024347, 5941.792037278675, 490.31111288639516, 494.50055444001816, 499.620288580674, 504.57111455263464, 506.95944324453956, 3857.498525191707, 3897.7466464679705, 3932.508436445444, 3953.0, 3986.1031267964477, 9556.378835375679, 9723.513824308757, 10283.434411107311, 10343.37939723619, 10424.426656533811, 9550.522473876417, 10559.260851740459, 10560.47197640115, 10560.47197640115, 10577.418241996764, 7256.8911466328045, 7899.486533375312, 7952.324052455606, 8081.717139900193, 8110.0673422557165, 5654.915176272441, 5748.971255143698, 5794.565407594363, 5802.47777700009, 5894.322152952465, 9812.754681132743, 9819.9018009819, 9876.85184722244, 9881.258905581966, 9923.503824808586, 10074.597016119273, 10081.344712593658, 10095.848562271718, 10101.949490252502, 10229.181665466893, 7514.0607424071995, 7555.433342499225, 7602.771916842504, 7609.782434810404, 7612.543247405173, 8003.839923201387, 8074.919250807652, 8116.026076870813, 8129.634166462642, 8130.512169269863, 7038.085048943604, 7150.713971441084, 7216.7113315466795, 7365.1530074042175, 7401.5189012714, 6759.87999740434, 6957.026016357815, 6969.0940177776565, 6972.616506092214, 7171.533850299714, 6734.0, 6906.551074180162, 6911.308869113049, 6913.274106218976, 6919.515633905578, 4858.27125931099, 4934.087193869145, 4991.725455100004, 4994.300797888226, 5015.924761128659, 4774.530521111643, 4833.0, 4867.683600565952, 4942.986687728935, 5049.697018178921], "value": 4491.381933368761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.62553063976424, 343.1318763528273, 343.61686719307977, 346.5494856686308, 353.17357383722083, 5444.4011158772555, 5466.835994920159, 5518.089515229983, 5535.308086489189, 5551.250581171541, 5442.782288708447, 5455.8363249102595, 5473.589480788947, 5474.124140137579, 5477.698726570037, 4293.420388247593, 4306.8277268909205, 4350.630196433307, 4365.36702178184, 4383.4739831220295, 3873.8063096845185, 4009.939850902239, 4201.936970945439, 4302.20409224293, 4302.247106756321, 4251.149770046003, 4257.808398622069, 4265.616094551489, 4286.271333873234, 4293.484781826185, 4282.978585107086, 4322.697411181219, 4330.242207613671, 4343.0, 4345.109252603241, 3669.119411341259, 3674.5590529136407, 3766.924661506782, 3781.470594116826, 3812.1232116613332, 5225.99505284463, 5238.319018527605, 5240.6069544784295, 5247.921281180786, 5339.305890234284, 4902.950970490285, 4950.455449900508, 4974.179260422026, 4980.936723914802, 4984.401871775374, 5408.378036525771, 5662.886742265173, 5696.806729409166, 5712.600117991742, 5714.51426628737, 4241.1941731071, 4243.172581346638, 4248.596383343577, 4248.936265956013, 4298.806553705091, 5556.749946252428, 5736.56975726818, 6004.519638428916, 6030.4572588467245, 6052.788152414689, 4309.913801723948, 4311.892202694958, 4324.0919406924895, 4325.205039908466, 4337.522872484024, 4369.847055353048, 4378.277584198571, 4398.538153493901, 4399.186150562156, 4409.625181859514, 4878.658493905464, 4954.529319714621, 5004.124278251292, 5006.19900815875, 5016.523430274118, 5586.636868603609, 5669.943300567024, 5685.204071430003, 5714.428557144252, 5819.214406055128, 1486.4425840309884, 1508.1328236264192, 1509.7810817431412, 1519.5061604978425, 1533.2333833083458, 960.5677445149711, 1000.7798284377425, 1004.4826914139225, 1008.3143462445461, 1020.0, 4899.216125419915, 4916.164252077156, 4930.260460930889, 4933.925991110136, 4938.38270216223, 5172.818951336685, 5193.0, 5196.350456192976, 5197.350331208599, 5222.321098257202, 4927.334809800703, 4966.900661986812, 4988.376452943382, 5136.666116702402, 5585.301837270341, 3077.3691393264326, 3121.9063428097193, 3138.2625083105454, 3138.7802853800013, 3141.418837515067, 6124.846878827976, 6137.232845894263, 6139.938600614026, 6155.753769849156, 6170.642458659087, 5741.282339707536, 6022.969885150546, 6039.248617900847, 6042.335343112254, 6049.667268300285, 6123.908141377794, 6123.908141377794, 6129.478994285447, 6132.264128304632, 6202.255729312511, 5678.318601767649, 5949.375315591974, 5974.9103763444455, 5978.461938425388, 6045.879082418415, 5834.0, 5835.503982161394, 5846.258394627527, 5878.2358293421585, 5884.529237661062, 5670.234518340137, 5812.041013232938, 5976.7908123215475, 5987.5808693391045, 6123.173371594778, 4204.873853784391, 4220.366944958281, 4231.344141658048, 4231.492220933507, 4239.321708526621, 5792.507636850914, 5964.075568286922, 6002.609830361012, 6009.188759517409, 6010.819675409744, 5745.511631511368, 5764.36591974874, 5784.0, 5801.94198058014, 5805.738741756547, 5790.0, 5801.216835727291, 5804.477597016289, 5806.312991250671, 5820.708964551671, 5517.779288828402, 5683.943160568341, 5710.000749868674, 5740.770369185186, 5769.711514424346, 5782.739776709974, 5787.016207244695, 5827.271591051119, 5845.620034697731, 5881.94118058831, 5697.316322041382, 5728.713564321684, 5739.818868829985, 5769.3942136076785, 5794.0], "value": 4372.416085506407, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.0604026845637, 736.4918206437558, 744.084775725857, 768.19339693322, 782.9686812527499, 14267.928660356696, 15112.244387780622, 15352.232388380578, 15392.0, 15759.290831912564, 14637.0, 14927.32827022784, 14943.775843362359, 14963.700725985474, 14996.0, 701.7333413302938, 720.4308596208989, 822.5106061893179, 835.6364981233153, 839.7102999465175, 815.233680340481, 835.6615570693879, 842.5492361586553, 844.7170197983683, 844.7550210438965, 874.8993865705462, 877.5042101212795, 877.5568337989306, 877.714742708619, 877.863931090682, 726.2918654312003, 744.9068866391701, 873.9563021848913, 874.8381549413378, 875.011237301848, 551.2860845205469, 551.8289330307617, 631.059721015688, 645.554567348528, 645.8869697802912, 13644.863551364459, 13649.454021839114, 13651.863481365159, 13673.589792306248, 13716.108452950526, 13714.0, 13796.655083622889, 13964.371603277878, 14343.928280358532, 14513.129212247299, 13296.628216061492, 13388.129771564818, 13452.663683407894, 13631.407304140028, 13816.654583635389, 4483.730976141442, 4536.954630453686, 4547.431571053618, 4678.391809064799, 4735.502772208937, 82535.58732206361, 85861.57069214614, 86051.26718030444, 86943.13056869413, 87224.56387718084, 11123.833142502868, 11238.55045798159, 11293.209475336811, 11347.432628368548, 11653.359065251323, 20661.483462913246, 20806.271780487612, 20876.686849697267, 20932.476688082614, 21316.680249796267, 8226.506409615442, 8540.70107546233, 8633.611487483078, 8688.739337819876, 8976.102389760972, 4608.746518941491, 5027.4218464877, 5099.69401835891, 5113.258577506241, 5161.329027226437, 3297.274599588087, 3412.4540073588105, 3422.0418282880833, 3422.5379573757723, 3423.726101911891, 582.1500609110745, 595.1994567306965, 604.1360853978765, 612.1582823617526, 617.996910015447, 657.8059472455637, 683.480554778372, 691.6265216782881, 696.0186137546137, 713.2475238623302, 8892.244159246407, 9037.548122593844, 9052.773680658036, 9090.591691480533, 9228.0, 659.1661548141604, 676.9830754231085, 678.8947713104477, 706.7561691216522, 739.2348918868945, 4361.542038085955, 4378.890527736832, 4394.0, 4476.574725401082, 4485.46174459067, 129723.0, 130031.0, 130570.34714826365, 131504.0, 136589.0, 65285.347146528875, 106455.46772266243, 106642.46678766712, 112141.0, 112222.0, 98199.0, 100554.49722751339, 101894.0, 102807.48596256971, 102902.48548757208, 8219.630116644646, 8490.448120872123, 8565.57172141403, 8577.528235946833, 8704.564771761514, 57785.71107144606, 58004.0, 59167.40832591791, 59411.405885940585, 60091.699541502014, 74947.62526187334, 85070.0, 85697.57151214204, 86190.56904715436, 86491.0, 11339.262947908359, 11652.126090543412, 11811.763764724828, 11827.940860295643, 11989.520419183134, 12795.360231988177, 12890.0, 12932.741345173232, 13108.344582771015, 13146.802797957847, 12403.503859845505, 12454.43955022008, 12463.750724985632, 12562.560310389092, 12591.622251332476, 11090.112790976542, 11496.712582185512, 11829.349385783864, 11930.821037684615, 11946.163768536118, 11100.944495277472, 11514.712132196762, 11750.529978800752, 12032.819507707216, 12207.572734954234, 10527.789444211227, 10728.409937453514, 10845.349279043283, 10987.945060274647, 11288.717782055513, 9988.800223995624, 10644.254902156774, 10764.192685548458, 10983.450827458755, 11865.912802616958], "value": 7517.01297790632, "unit": "score"}], "name": "dromaeo_css", "value": 7478.344838178276, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 111.0, 112.0, 113.0, 111.0, 112.0, 111.0, 113.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 118.0, 143.0, 124.0, 123.0, 115.0, 122.0, 157.0, 123.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 117.0, 75.0, 76.0, 75.0, 77.0, 96.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 111.0, 80.0, 80.0, 81.0, 100.0, 80.0, 79.0, 107.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 48.0, 49.0, 48.0, 51.0, 49.0, 48.0, 48.0, 48.0], "value": 48.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 73.0, 73.0, 81.0, 73.0, 74.0, 81.0, 73.0, 73.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 123.0, 130.0, 132.0, 121.0, 121.0, 117.0, 117.0, 168.0, 122.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 159.0, 153.0, 153.0, 154.0, 153.0, 154.0, 153.0, 152.0], "value": 153.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 62.0, 62.0, 63.0, 62.0, 61.0, 61.0, 61.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1455.2000000000003, "alertThreshold": 2.0}]} 07:39:00 INFO - Return code: 0 07:39:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:39:00 INFO - # TBPL SUCCESS # 07:39:00 INFO - Running post-action listener: _resource_record_post_action 07:39:00 INFO - [mozharness: 2016-11-04 14:39:00.603968Z] Finished run-tests step (success) 07:39:00 INFO - Running post-run listener: _resource_record_post_run 07:39:00 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 2727936; Write bytes: 370466816; Read time: 1152; Write time: 217468 07:39:00 INFO - TinderboxPrint: CPU usage
12.9% 07:39:00 INFO - TinderboxPrint: I/O read bytes / time
2,727,936 / 1,152 07:39:00 INFO - TinderboxPrint: I/O write bytes / time
370,466,816 / 217,468 07:39:00 INFO - TinderboxPrint: CPU idle
8,274.5 (87.0%) 07:39:00 INFO - TinderboxPrint: CPU user
1,187.0 (12.5%) 07:39:00 INFO - TinderboxPrint: Swap in / out
0 / 0 07:39:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118784000; Read time: 0; Write time: 95848 07:39:00 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 2727936; Write bytes: 250785792; Read time: 1152; Write time: 121592 07:39:01 INFO - Running post-run listener: _upload_blobber_files 07:39:01 INFO - Blob upload gear active. 07:39:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:39:01 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 07:39:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:39:01 INFO - (blobuploader) - INFO - Open directory for files ... 07:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:39:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:02 INFO - (blobuploader) - INFO - Done attempting. 07:39:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:39:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:39:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:03 INFO - (blobuploader) - INFO - Done attempting. 07:39:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:39:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:39:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:39:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:39:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:39:06 INFO - (blobuploader) - INFO - Done attempting. 07:39:06 INFO - (blobuploader) - INFO - Iteration through files over. 07:39:06 INFO - Return code: 0 07:39:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:39:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:39:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df84044d9eef077a56271b1a8c17a052c9d92bdf3c9001fb066ab7c94615df2e5f46fc2d067592f79963a6d992f631247ef23b086713514bbfa13cb03b021901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebd9b4a1fb180521bd27498a1c1a394cd3758096a6e67912794017929d8e79d697329e38e52127559db774d9af049ebb75938c7f8cce755978c6bad6651e64e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/178293eeb05798fdb70ba946bbf8e8f49bb960f66549ce639b53400a06ad2a74617a231155d37a08890f575715ebbe38171bc8492125787e1bf5f85ef702670b"} 07:39:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:39:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:39:06 INFO - Contents: 07:39:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df84044d9eef077a56271b1a8c17a052c9d92bdf3c9001fb066ab7c94615df2e5f46fc2d067592f79963a6d992f631247ef23b086713514bbfa13cb03b021901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebd9b4a1fb180521bd27498a1c1a394cd3758096a6e67912794017929d8e79d697329e38e52127559db774d9af049ebb75938c7f8cce755978c6bad6651e64e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/178293eeb05798fdb70ba946bbf8e8f49bb960f66549ce639b53400a06ad2a74617a231155d37a08890f575715ebbe38171bc8492125787e1bf5f85ef702670b"} 07:39:06 INFO - Running post-run listener: copy_logs_to_upload_dir 07:39:06 INFO - Copying logs to upload dir... 07:39:06 INFO - mkdir: /builds/slave/test/build/upload/logs 07:39:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.280924 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-11-04 07:39:05.443854) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 07:39:05.447552) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df84044d9eef077a56271b1a8c17a052c9d92bdf3c9001fb066ab7c94615df2e5f46fc2d067592f79963a6d992f631247ef23b086713514bbfa13cb03b021901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebd9b4a1fb180521bd27498a1c1a394cd3758096a6e67912794017929d8e79d697329e38e52127559db774d9af049ebb75938c7f8cce755978c6bad6651e64e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/178293eeb05798fdb70ba946bbf8e8f49bb960f66549ce639b53400a06ad2a74617a231155d37a08890f575715ebbe38171bc8492125787e1bf5f85ef702670b"} build_url:https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011400 build_url: 'https://queue.taskcluster.net/v1/task/CYIXFJKZRcKuK15i_X1d2Q/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df84044d9eef077a56271b1a8c17a052c9d92bdf3c9001fb066ab7c94615df2e5f46fc2d067592f79963a6d992f631247ef23b086713514bbfa13cb03b021901", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ebd9b4a1fb180521bd27498a1c1a394cd3758096a6e67912794017929d8e79d697329e38e52127559db774d9af049ebb75938c7f8cce755978c6bad6651e64e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/178293eeb05798fdb70ba946bbf8e8f49bb960f66549ce639b53400a06ad2a74617a231155d37a08890f575715ebbe38171bc8492125787e1bf5f85ef702670b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-04 07:39:05.474636) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 07:39:05.474978) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1478269110.859435-1579250044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-04 07:39:05.557093) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 07:39:05.557422) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-04 07:39:05.557716) ========= ========= Total master_lag: 0.16 =========